[09:10:26.331] New invocation is queued and will start shortly
[09:10:27.475] Starting the invocation (attempt 1)
[09:10:27.516] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:10:27.516] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:10:27.516] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020309604549887008",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"35874913f1b700274d8e93fd735243030538cdaf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9020309604549887008",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/35874913f1b700274d8e93fd735243030538cdaf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/35874913f1b700274d8e93fd735243030538cdaf",
"gitiles_ref:refs/heads/master"
]
}
[09:10:28.283] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613725827697543",
"id": "8854879542454652880",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"35874913f1b700274d8e93fd735243030538cdaf\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613725828118482",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180741",
"builder:Linux Builder (dbg)",
"buildset:commit/git/35874913f1b700274d8e93fd735243030538cdaf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/35874913f1b700274d8e93fd735243030538cdaf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020309604549887008",
"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/8854879542454652880/+/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": "1613725828118632",
"url": "https://ci.chromium.org/b/8854879542454652880",
"utcnow_ts": "1613725828276234"
}
}
[09:10:28.283] Task URL: https://ci.chromium.org/b/8854879542454652880
[09:10:28.283] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:2:0) after 1m0s
[09:10:57.744] Received PubSub notification, asking Buildbucket for the build status
[09:10:57.821] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:28.365] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:2:0)
[09:11:28.365] Timer tick, asking Buildbucket for the build status
[09:11:28.461] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:28.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:4:0) after 1m0s
[09:12:28.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:4:0)
[09:12:28.465] Timer tick, asking Buildbucket for the build status
[09:12:28.536] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:28.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:5:0) after 1m0s
[09:13:28.556] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:5:0)
[09:13:28.556] Timer tick, asking Buildbucket for the build status
[09:13:28.636] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:28.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:6:0) after 1m0s
[09:14:28.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:6:0)
[09:14:28.679] Timer tick, asking Buildbucket for the build status
[09:14:28.841] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:28.841] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:7:0) after 1m0s
[09:15:28.816] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:7:0)
[09:15:28.816] Timer tick, asking Buildbucket for the build status
[09:15:28.891] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:28.891] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:8:0) after 1m0s
[09:16:29.123] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:8:0)
[09:16:29.123] Timer tick, asking Buildbucket for the build status
[09:16:29.257] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:29.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:9:0) after 1m0s
[09:17:29.309] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:9:0)
[09:17:29.309] Timer tick, asking Buildbucket for the build status
[09:17:30.076] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:30.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:10:0) after 1m0s
[09:18:30.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:10:0)
[09:18:30.164] Timer tick, asking Buildbucket for the build status
[09:18:30.721] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:30.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:11:0) after 1m0s
[09:19:30.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:11:0)
[09:19:30.801] Timer tick, asking Buildbucket for the build status
[09:19:30.872] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:30.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:12:0) after 1m0s
[09:20:30.855] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:12:0)
[09:20:30.855] Timer tick, asking Buildbucket for the build status
[09:20:30.940] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:30.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:13:0) after 1m0s
[09:21:30.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:13:0)
[09:21:30.959] Timer tick, asking Buildbucket for the build status
[09:21:31.046] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:31.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:14:0) after 1m0s
[09:22:31.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:14:0)
[09:22:31.066] Timer tick, asking Buildbucket for the build status
[09:22:31.237] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:31.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:15:0) after 1m0s
[09:23:31.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:15:0)
[09:23:31.221] Timer tick, asking Buildbucket for the build status
[09:23:31.298] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:31.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:16:0) after 1m0s
[09:24:31.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:16:0)
[09:24:31.318] Timer tick, asking Buildbucket for the build status
[09:24:31.399] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:31.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:17:0) after 1m0s
[09:25:31.416] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:17:0)
[09:25:31.416] Timer tick, asking Buildbucket for the build status
[09:25:31.517] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:31.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:18:0) after 1m0s
[09:26:31.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:18:0)
[09:26:31.627] Timer tick, asking Buildbucket for the build status
[09:26:31.821] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:31.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:19:0) after 1m0s
[09:27:31.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:19:0)
[09:27:31.950] Timer tick, asking Buildbucket for the build status
[09:27:32.021] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:32.021] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:20:0) after 1m0s
[09:28:32.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:20:0)
[09:28:32.158] Timer tick, asking Buildbucket for the build status
[09:28:33.131] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:33.131] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:21:0) after 1m0s
[09:29:33.234] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:21:0)
[09:29:33.234] Timer tick, asking Buildbucket for the build status
[09:29:33.363] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:33.363] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:22:0) after 1m0s
[09:30:33.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:22:0)
[09:30:33.424] Timer tick, asking Buildbucket for the build status
[09:30:33.646] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:33.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:23:0) after 1m0s
[09:31:33.696] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:23:0)
[09:31:33.696] Timer tick, asking Buildbucket for the build status
[09:31:33.829] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:33.829] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:24:0) after 1m0s
[09:32:33.880] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:24:0)
[09:32:33.880] Timer tick, asking Buildbucket for the build status
[09:32:33.968] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:33.968] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:25:0) after 1m0s
[09:33:33.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:25:0)
[09:33:33.975] Timer tick, asking Buildbucket for the build status
[09:33:34.117] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:34.117] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:26:0) after 1m0s
[09:34:34.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:26:0)
[09:34:34.194] Timer tick, asking Buildbucket for the build status
[09:34:34.421] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:34.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:27:0) after 1m0s
[09:35:34.470] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:27:0)
[09:35:34.470] Timer tick, asking Buildbucket for the build status
[09:35:34.846] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:34.846] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:28:0) after 1m0s
[09:36:34.941] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:28:0)
[09:36:34.941] Timer tick, asking Buildbucket for the build status
[09:36:35.037] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:35.037] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:29:0) after 1m0s
[09:37:35.121] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:29:0)
[09:37:35.121] Timer tick, asking Buildbucket for the build status
[09:37:35.355] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:35.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:30:0) after 1m0s
[09:38:35.411] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:30:0)
[09:38:35.411] Timer tick, asking Buildbucket for the build status
[09:38:35.479] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:35.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:31:0) after 1m0s
[09:39:35.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:31:0)
[09:39:35.686] Timer tick, asking Buildbucket for the build status
[09:39:35.765] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:35.765] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:32:0) after 1m0s
[09:40:35.805] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:32:0)
[09:40:35.805] Timer tick, asking Buildbucket for the build status
[09:40:35.927] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:35.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:33:0) after 1m0s
[09:41:35.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:33:0)
[09:41:35.970] Timer tick, asking Buildbucket for the build status
[09:41:36.061] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:36.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:34:0) after 1m0s
[09:42:36.163] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:34:0)
[09:42:36.163] Timer tick, asking Buildbucket for the build status
[09:42:36.258] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:36.258] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:35:0) after 1m0s
[09:43:36.398] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:35:0)
[09:43:36.398] Timer tick, asking Buildbucket for the build status
[09:43:36.487] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:36.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:36:0) after 1m0s
[09:44:36.590] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:36:0)
[09:44:36.590] Timer tick, asking Buildbucket for the build status
[09:44:36.833] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:36.833] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:37:0) after 1m0s
[09:45:37.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:37:0)
[09:45:37.424] Timer tick, asking Buildbucket for the build status
[09:45:37.568] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:37.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:38:0) after 1m0s
[09:46:37.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:38:0)
[09:46:37.743] Timer tick, asking Buildbucket for the build status
[09:46:37.980] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:37.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:39:0) after 1m0s
[09:47:38.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:39:0)
[09:47:38.015] Timer tick, asking Buildbucket for the build status
[09:47:38.244] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:38.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:40:0) after 1m0s
[09:48:38.303] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:40:0)
[09:48:38.303] Timer tick, asking Buildbucket for the build status
[09:48:38.387] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:38.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:41:0) after 1m0s
[09:49:38.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:41:0)
[09:49:38.374] Timer tick, asking Buildbucket for the build status
[09:49:38.442] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:38.442] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:42:0) after 1m0s
[09:50:38.544] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:42:0)
[09:50:38.544] Timer tick, asking Buildbucket for the build status
[09:50:38.663] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:38.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:43:0) after 1m0s
[09:51:38.737] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:43:0)
[09:51:38.737] Timer tick, asking Buildbucket for the build status
[09:51:38.820] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:38.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:44:0) after 1m0s
[09:52:38.799] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:44:0)
[09:52:38.799] Timer tick, asking Buildbucket for the build status
[09:52:38.867] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:38.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:45:0) after 1m0s
[09:53:38.899] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:45:0)
[09:53:38.899] Timer tick, asking Buildbucket for the build status
[09:53:38.977] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:38.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:46:0) after 1m0s
[09:54:39.051] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:46:0)
[09:54:39.051] Timer tick, asking Buildbucket for the build status
[09:54:39.190] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:39.190] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:47:0) after 1m0s
[09:55:39.280] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:47:0)
[09:55:39.280] Timer tick, asking Buildbucket for the build status
[09:55:39.375] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:39.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:48:0) after 1m0s
[09:56:39.995] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:48:0)
[09:56:39.995] Timer tick, asking Buildbucket for the build status
[09:56:40.082] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:40.082] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:49:0) after 1m0s
[09:57:40.249] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:49:0)
[09:57:40.249] Timer tick, asking Buildbucket for the build status
[09:57:40.324] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:40.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:50:0) after 1m0s
[09:58:40.408] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:50:0)
[09:58:40.408] Timer tick, asking Buildbucket for the build status
[09:58:40.532] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:40.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:51:0) after 1m0s
[09:59:40.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:51:0)
[09:59:40.650] Timer tick, asking Buildbucket for the build status
[09:59:40.737] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:40.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:52:0) after 1m0s
[10:00:41.017] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:52:0)
[10:00:41.017] Timer tick, asking Buildbucket for the build status
[10:00:41.153] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:41.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:53:0) after 1m0s
[10:01:41.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:53:0)
[10:01:41.409] Timer tick, asking Buildbucket for the build status
[10:01:41.492] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:41.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:54:0) after 1m0s
[10:02:41.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:54:0)
[10:02:41.782] Timer tick, asking Buildbucket for the build status
[10:02:41.854] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:41.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:55:0) after 1m0s
[10:03:41.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:55:0)
[10:03:41.918] Timer tick, asking Buildbucket for the build status
[10:03:41.988] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:41.988] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:56:0) after 1m0s
[10:04:41.995] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:56:0)
[10:04:41.995] Timer tick, asking Buildbucket for the build status
[10:04:42.095] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:42.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:57:0) after 1m0s
[10:05:42.198] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:57:0)
[10:05:42.198] Timer tick, asking Buildbucket for the build status
[10:05:42.315] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:42.315] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:58:0) after 1m0s
[10:06:42.385] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:58:0)
[10:06:42.385] Timer tick, asking Buildbucket for the build status
[10:06:42.487] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:42.487] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:59:0) after 1m0s
[10:07:42.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:59:0)
[10:07:42.532] Timer tick, asking Buildbucket for the build status
[10:07:42.749] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:42.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:60:0) after 1m0s
[10:08:42.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:60:0)
[10:08:42.844] Timer tick, asking Buildbucket for the build status
[10:08:42.922] Build 8854879542454652880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:42.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020309604549887008:61:0) after 1m0s
[10:09:05.695] Received PubSub notification, asking Buildbucket for the build status
[10:09:05.817] Build 8854879542454652880: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:09:05.817] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613729344623624",
"created_by": "project:chromium",
"created_ts": "1613725827697543",
"id": "8854879542454652880",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"35874913f1b700274d8e93fd735243030538cdaf\"}}",
"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\": \"35874913f1b700274d8e93fd735243030538cdaf\", \"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-206-d74r\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180741, \"got_angle_revision\": \"fd132e4e7a9c84333b4fb4730f79367fe75f53e7\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"35874913f1b700274d8e93fd735243030538cdaf\", \"got_revision_cp\": \"refs/heads/master@{#855658}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8603b126b3d599f0ab8781163729fd226a93cf17\", \"got_v8_revision\": \"aaf128851c4dd86978eaf9d41ce297c5af31597f\", \"got_v8_revision_cp\": \"refs/heads/9.0.217@{#1}\", \"got_webrtc_revision\": \"735e33fae0a06ae05a9c0be6f5d8b06a6ad820a4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33297}\", \"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\": \"35874913f1b700274d8e93fd735243030538cdaf\", \"swarm_hashes_refs/heads/master(at){#855658}_without_patch\": {\"absl_hardening_tests\": \"ea13295ce48a93ea1c111243e9692b5569aba70f\", \"accessibility_unittests\": \"9ac78e549a8dec181e165561d43cfaf2690af890\", \"angle_unittests\": \"813c458606e08462a8b96d293e074fdfb3871f5c\", \"app_shell_unittests\": \"1b95e1edab187fd40c20f07c8bb2ffd5177f52df\", \"aura_unittests\": \"1f7896d2bc1aa0fc4829610ebdf00c44aff6ea8b\", \"base_unittests\": \"79d40501798e289c396b0b3e99d0cbc45c04f35a\", \"base_util_unittests\": \"51488229683c06ec6ac556939365a313c7626d48\", \"blink_common_unittests\": \"4368c656b4b12fdf9d2821d5af0507a886dc90e1\", \"blink_fuzzer_unittests\": \"3bc0cced1a64c220b72b37c2342848ac721425d8\", \"blink_heap_unittests\": \"53d42dc00d5f5e014fb1913ef7919c684565c4d6\", \"blink_platform_unittests\": \"8e201c1bf0f4c4fe6197111d219f421770446967\", \"blink_python_tests\": \"a2476d84d4a97d0126d6da545739fb8b6eb6a44b\", \"blink_unittests\": \"57d89329b46963311fef602c57eff2ef430ea8f1\", \"blink_web_tests\": \"03505e7fcb52584129d579052edefd61e1a063c0\", \"boringssl_crypto_tests\": \"48f3af5a36abaf8bc39864eb22548554b9c093a6\", \"boringssl_ssl_tests\": \"5f4a509e6291b6648d6cd0a86bd903c219e3efb9\", \"browser_tests\": \"98683dc298fc561492dc607320d3171d01626b0c\", \"capture_unittests\": \"ee24cf4b33ddcdcf8229d442a168b1b6b93078c2\", \"cast_unittests\": \"fe3c0a49ff95050273d0a62f824ef8d0a90b1674\", \"cc_unittests\": \"98a452530768be867cdb6c9a43c43dcc2c677f74\", \"chrome_app_unittests\": \"7f07e908aab7fb863e55fbbdc9497ca9cab9e915\", \"chromedriver_unittests\": \"19f7fced8e8189b9246be94e56ac1b78fef8ddd1\", \"components_browsertests\": \"983fb50e2e5612e05f34fc40411017f171c8cdd3\", \"components_unittests\": \"e87a0c7ee883e6f0b52a14c376f5a1836b39d6b2\", \"compositor_unittests\": \"15a60fd51a06fc337a4886555f37dfe2fef3e290\", \"content_browsertests\": \"643a4284a0e612f1e4b29a4d6ef350664b6e648a\", \"content_shell_crash_test\": \"f97fd8ebfc2c3ccdc2bc611eb966d2bd28a40f7f\", \"content_unittests\": \"4066140293414a71092a49179de606cf06721572\", \"crashpad_tests\": \"21f2b2918597c5d56aeb1e66e61315adac81f37c\", \"cronet_tests\": \"cdca72553692ce600253dd5fd324ce69dba87111\", \"cronet_unittests\": \"76feb95cd0c73aa7e3f191f471397259501337c8\", \"crypto_unittests\": \"f5adf5b112f36dca3b9c087d579edff17afac845\", \"dbus_unittests\": \"965ecc73ee8668dd795446a6677dc9d1cefd36de\", \"device_unittests\": \"b748581e0b984dba0ad7f0b423ba8fcc43982458\", \"display_unittests\": \"defd489b5ce092cd26757db5290d764e6e8cba60\", \"events_unittests\": \"91d3326c0e8f11ee7d30280c5cbe7cb78d6406f3\", \"extensions_browsertests\": \"0403f7670b4e4e1d19b16f03a73a237c68f374c1\", \"extensions_unittests\": \"7814b97e79068569056fb0497c27e5414c0acf18\", \"filesystem_service_unittests\": \"ff3b05e71a18f5e0914a76124d9ab9406b9ab3c1\", \"flatbuffers_unittests\": \"698230cd2ee29799b3293b30c69cdc80b3ff243d\", \"gcm_unit_tests\": \"57a9bb544fff067601dc4b5c1a5511ffb73fec29\", \"gfx_unittests\": \"9572ea3b09808d5ac0d52451ab626b8a0e39fa2c\", \"gin_unittests\": \"35bdfe49dd2a247342e28e9a8e57a02164aa87c4\", \"google_apis_unittests\": \"7983ab2f56b20d74b101976411f0ec85c331d30e\", \"gpu_unittests\": \"341519d2188e2ac8c1827c91bf053fe2439e64cb\", \"grit_python_unittests\": \"e9472d6ec31317123f3dfff9be51bd5eb8f9349b\", \"gwp_asan_unittests\": \"23dd335574b760b00237dce18ed34b19965c670d\", \"headless_browsertests\": \"8287b1a4bb1f39292decb7e94fa6e62dc033e46b\", \"headless_unittests\": \"575fbbfcc1abc30625af0f66d9084a5833fc79e8\", \"interactive_ui_tests\": \"09d57d2179fb8c2630111090fbd34d4edea1d5e5\", \"ipc_tests\": \"dee671adf3324ee8e2254fd61121868598f14704\", \"jingle_unittests\": \"f900372775231aff07ce4948d5e318f617fe54fd\", \"latency_unittests\": \"d5654bdcafd6bd67377948c5578827c50df43c7e\", \"libjingle_xmpp_unittests\": \"ed4ec1fe36f5876f1de8e962566485fab7788d9e\", \"liburlpattern_unittests\": \"b13f5fb2c7b2e3201e87f24053eb24d4bbd3c1ea\", \"media_blink_unittests\": \"646650e79e8b08c0323461d8a56e23105bd54ce9\", \"media_unittests\": \"31de06d2d987f3f4348cde53336c6b750da5e9e3\", \"message_center_unittests\": \"aba42f55255992a23ad9dd31adf8a6b4ba599da0\", \"metrics_python_tests\": \"6c6779439504cbbd3bbfb230a5a1a914d5413e8f\", \"midi_unittests\": \"84a48020360cc6539eaeeab9ab8389a8895a7a4b\", \"mojo_core_unittests\": \"7a9df45427df3c4455f7b65a4d4b1f0fcd9194c2\", \"mojo_unittests\": \"a1024b77592c56d0c4c4808f57819af4897092ac\", \"nacl_helper_nonsfi_unittests\": \"e976280b6ad2d44029ba238553022313058d556e\", \"nacl_loader_unittests\": \"61ac4863d7ec66048794160b37a08c55b34b92c9\", \"native_theme_unittests\": \"13f820134988e0b70fcb50d4881feffb4dff50fa\", \"net_unittests\": \"de805c6b6ed03e7cb392d2b387f1c5294fbdb34a\", \"openscreen_unittests\": \"e308b353f75ac32dc1cfd986a07b2dfd2764e92f\", \"pdf_unittests\": \"fb4566a4c8ad256c522e9efd2170de18da03c484\", \"perfetto_unittests\": \"d05aa4886b2b406ddc1f4035433e3d2704a7b3f4\", \"ppapi_unittests\": \"1206e1b39a2c2c86cefb53c3d18ddb5fce67d809\", \"printing_unittests\": \"16431382906352e009cb2f04b895e64d7d029894\", \"remoting_unittests\": \"07aeed707aa022d6f244e25582b6e381621e7fe2\", \"sandbox_linux_unittests\": \"90535369d9ad87d19983b6118faab9e60f3f59fc\", \"service_manager_unittests\": \"62b178fdd37e291cb130863ba0483ce2f295eb1d\", \"services_unittests\": \"9053ec5536d74ab03331747c80c7bce987b95242\", \"shell_dialogs_unittests\": \"2088243af3f47b5603df8d1ae17bfb50effa785c\", \"skia_unittests\": \"02e07fda9810dfbbd4897df6bc76f73e5a7dc3d8\", \"snapshot_unittests\": \"c41372120da44f64947d0c00f07587f3330e5adb\", \"sql_unittests\": \"e45e8c3b940a88fb630bbaf6bdd0f6e35681dc07\", \"storage_unittests\": \"a0f1f8ae7340941752b39920662c27113d45ef85\", \"sync_integration_tests\": \"592fb5fa4e171fc7faece31a8d01b9ac201964a9\", \"telemetry_gpu_unittests\": \"1912e340dd9d3c0715917ef589c11ed49ec4d8d5\", \"telemetry_perf_unittests\": \"babf1c0b45ec6d61f33664995705ca8baac27583\", \"telemetry_unittests\": \"753163f41e63693b6a34dd494e73decf4ce5327f\", \"traffic_annotation_auditor_unittests\": \"90acc8c0746c0c64d1001f40b1b33367b2a7856c\", \"ui_base_unittests\": \"c99982da5ca7ceccd7eaf3694c3bef50460ed656\", \"ui_touch_selection_unittests\": \"1345cb2982365225ef86352b3460911b9174ef73\", \"unit_tests\": \"6d95500aaf4076a521d334c39af186df28f2b441\", \"url_unittests\": \"50c7c7b24b3caa514e9b809237cc42e8e4e78a87\", \"views_perftests\": \"91451ce69d785f5bd7fd0c70b603035fc32f94e7\", \"views_unittests\": \"a6fec1b356401bf6a9b8061c7fb3f3983626ad11\", \"viz_unittests\": \"e9fa24dd1c083733d20a0ba728d885c832fcaf8d\", \"vr_common_unittests\": \"eea203e3b991fc5f20ba7450b920bb998689e664\", \"vr_pixeltests\": \"5559748a868c53d512f51b15f5a0a8868861a5c6\", \"webdriver_wpt_tests\": \"2936e0262148c96c9b58020c614097e71b7edaf2\", \"weblayer_browsertests\": \"1070141b13223afb183197ae65582b4ca6ec86ab\", \"weblayer_unittests\": \"a47e05e3d3e3940858f4490a265f721c98dd1e6b\", \"wm_unittests\": \"c9e55d3be2d9a9c644220da857ae1f9976e636ac\", \"wtf_unittests\": \"032779e46deb2bb663d80dfb6019a8df315c5514\", \"x11_unittests\": \"82e46070875ec7c1200f9975a71f96da84275567\", \"xr_browser_tests\": \"c35397ad48539665dbc32fa3d4fda528dccbace1\", \"zlib_unittests\": \"c4eeec5b7cf7e1ca342abdbaac8de37bbda04546\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2da0bee4e22251567f731cb4ff4725bbbd697db00236c0e7ca4bd76c7874f95c_v2\", \"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_47c3ec4238d3b3d0448e41826f5b2c1435e77a4255b8c93aa27077a59a7a5a67_v2\", \"builder_d7cc7c59327c05146a034898ae78722818cd22c61c9435c4c4348e98bea5a132_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-206-d74r\"], \"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\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613725857202721",
"status": "COMPLETED",
"status_changed_ts": "1613729345124502",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180741",
"builder:Linux Builder (dbg)",
"buildset:commit/git/35874913f1b700274d8e93fd735243030538cdaf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/35874913f1b700274d8e93fd735243030538cdaf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020309604549887008",
"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/8854879542454652880/+/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:51d25f90eb203d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613729345132334",
"url": "https://ci.chromium.org/b/8854879542454652880",
"utcnow_ts": "1613729345809378"
}
}
[10:09:05.817] Invocation finished in 58m39.501688979s with status SUCCEEDED