[07:04:32.348] New invocation is queued and will start shortly
[07:04:33.446] Starting the invocation (attempt 1)
[07:04:33.483] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:04:33.484] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:04:33.484] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018596183114319200",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"075d29b4983b721ea92f39e7057c64f3f0a8a8df\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9018596183114319200",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/075d29b4983b721ea92f39e7057c64f3f0a8a8df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/075d29b4983b721ea92f39e7057c64f3f0a8a8df",
"gitiles_ref:refs/heads/master"
]
}
[07:04:34.105] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615359873564012",
"id": "8853166121175546560",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"075d29b4983b721ea92f39e7057c64f3f0a8a8df\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615359873987720",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181261",
"builder:Linux Builder (dbg)",
"buildset:commit/git/075d29b4983b721ea92f39e7057c64f3f0a8a8df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/075d29b4983b721ea92f39e7057c64f3f0a8a8df",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018596183114319200",
"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/8853166121175546560/+/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": "1615359873987825",
"url": "https://ci.chromium.org/b/8853166121175546560",
"utcnow_ts": "1615359874097197"
}
}
[07:04:34.105] Task URL: https://ci.chromium.org/b/8853166121175546560
[07:04:34.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:2:0) after 1m0s
[07:04:36.781] Received PubSub notification, asking Buildbucket for the build status
[07:04:36.852] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:34.241] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:2:0)
[07:05:34.241] Timer tick, asking Buildbucket for the build status
[07:05:34.343] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:34.343] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:4:0) after 1m0s
[07:06:34.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:4:0)
[07:06:34.421] Timer tick, asking Buildbucket for the build status
[07:06:34.486] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:34.486] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:5:0) after 1m0s
[07:07:34.560] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:5:0)
[07:07:34.560] Timer tick, asking Buildbucket for the build status
[07:07:34.630] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:34.631] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:6:0) after 1m0s
[07:08:35.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:6:0)
[07:08:35.076] Timer tick, asking Buildbucket for the build status
[07:08:35.138] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:35.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:7:0) after 1m0s
[07:09:35.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:7:0)
[07:09:35.193] Timer tick, asking Buildbucket for the build status
[07:09:35.287] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:35.287] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:8:0) after 1m0s
[07:10:35.272] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:8:0)
[07:10:35.272] Timer tick, asking Buildbucket for the build status
[07:10:35.360] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:35.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:9:0) after 1m0s
[07:11:35.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:9:0)
[07:11:35.459] Timer tick, asking Buildbucket for the build status
[07:11:35.543] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:35.543] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:10:0) after 1m0s
[07:12:35.656] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:10:0)
[07:12:35.656] Timer tick, asking Buildbucket for the build status
[07:12:35.899] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:35.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:11:0) after 1m0s
[07:13:35.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:11:0)
[07:13:35.918] Timer tick, asking Buildbucket for the build status
[07:13:35.987] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:35.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:12:0) after 1m0s
[07:14:36.029] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:12:0)
[07:14:36.029] Timer tick, asking Buildbucket for the build status
[07:14:36.172] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:36.172] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:13:0) after 1m0s
[07:15:36.171] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:13:0)
[07:15:36.171] Timer tick, asking Buildbucket for the build status
[07:15:36.526] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:36.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:14:0) after 1m0s
[07:16:36.528] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:14:0)
[07:16:36.528] Timer tick, asking Buildbucket for the build status
[07:16:36.596] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:36.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:15:0) after 1m0s
[07:17:36.684] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:15:0)
[07:17:36.684] Timer tick, asking Buildbucket for the build status
[07:17:36.936] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:36.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:16:0) after 1m0s
[07:18:36.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:16:0)
[07:18:36.976] Timer tick, asking Buildbucket for the build status
[07:18:37.041] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:37.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:17:0) after 1m0s
[07:19:37.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:17:0)
[07:19:37.082] Timer tick, asking Buildbucket for the build status
[07:19:37.256] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:37.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:18:0) after 1m0s
[07:20:37.271] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:18:0)
[07:20:37.271] Timer tick, asking Buildbucket for the build status
[07:20:37.338] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:37.338] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:19:0) after 1m0s
[07:21:37.400] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:19:0)
[07:21:37.400] Timer tick, asking Buildbucket for the build status
[07:21:37.512] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:37.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:20:0) after 1m0s
[07:22:37.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:20:0)
[07:22:37.608] Timer tick, asking Buildbucket for the build status
[07:22:37.758] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:37.758] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:21:0) after 1m0s
[07:23:37.741] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:21:0)
[07:23:37.741] Timer tick, asking Buildbucket for the build status
[07:23:38.006] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:38.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:22:0) after 1m0s
[07:24:38.104] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:22:0)
[07:24:38.104] Timer tick, asking Buildbucket for the build status
[07:24:38.463] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:38.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:23:0) after 1m0s
[07:25:38.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:23:0)
[07:25:38.511] Timer tick, asking Buildbucket for the build status
[07:25:38.579] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:38.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:24:0) after 1m0s
[07:26:38.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:24:0)
[07:26:38.630] Timer tick, asking Buildbucket for the build status
[07:26:38.951] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:38.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:25:0) after 1m0s
[07:27:38.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:25:0)
[07:27:38.930] Timer tick, asking Buildbucket for the build status
[07:27:39.114] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:39.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:26:0) after 1m0s
[07:28:39.205] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:26:0)
[07:28:39.205] Timer tick, asking Buildbucket for the build status
[07:28:39.576] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:39.576] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:27:0) after 1m0s
[07:29:39.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:27:0)
[07:29:39.675] Timer tick, asking Buildbucket for the build status
[07:29:39.939] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:39.939] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:28:0) after 1m0s
[07:30:39.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:28:0)
[07:30:39.968] Timer tick, asking Buildbucket for the build status
[07:30:40.144] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:40.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:29:0) after 1m0s
[07:31:40.185] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:29:0)
[07:31:40.185] Timer tick, asking Buildbucket for the build status
[07:31:40.261] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:40.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:30:0) after 1m0s
[07:32:40.345] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:30:0)
[07:32:40.345] Timer tick, asking Buildbucket for the build status
[07:32:40.418] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:40.418] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:31:0) after 1m0s
[07:33:40.433] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:31:0)
[07:33:40.433] Timer tick, asking Buildbucket for the build status
[07:33:43.008] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:43.008] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:32:0) after 1m0s
[07:34:43.052] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:32:0)
[07:34:43.052] Timer tick, asking Buildbucket for the build status
[07:34:43.532] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:43.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:33:0) after 1m0s
[07:35:43.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:33:0)
[07:35:43.545] Timer tick, asking Buildbucket for the build status
[07:35:43.626] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:43.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:34:0) after 1m0s
[07:36:43.738] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:34:0)
[07:36:43.738] Timer tick, asking Buildbucket for the build status
[07:36:43.808] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:43.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:35:0) after 1m0s
[07:37:43.838] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:35:0)
[07:37:43.838] Timer tick, asking Buildbucket for the build status
[07:37:43.903] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:43.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:36:0) after 1m0s
[07:38:43.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:36:0)
[07:38:43.885] Timer tick, asking Buildbucket for the build status
[07:38:44.015] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:44.015] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:37:0) after 1m0s
[07:39:44.083] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:37:0)
[07:39:44.083] Timer tick, asking Buildbucket for the build status
[07:39:44.187] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:44.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:38:0) after 1m0s
[07:40:44.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:38:0)
[07:40:44.321] Timer tick, asking Buildbucket for the build status
[07:40:44.417] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:44.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:39:0) after 1m0s
[07:41:44.513] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:39:0)
[07:41:44.513] Timer tick, asking Buildbucket for the build status
[07:41:44.637] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:44.637] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:40:0) after 1m0s
[07:42:44.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:40:0)
[07:42:44.685] Timer tick, asking Buildbucket for the build status
[07:42:44.760] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:44.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:41:0) after 1m0s
[07:43:44.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:41:0)
[07:43:44.742] Timer tick, asking Buildbucket for the build status
[07:43:44.824] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:44.824] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:42:0) after 1m0s
[07:44:44.897] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:42:0)
[07:44:44.897] Timer tick, asking Buildbucket for the build status
[07:44:45.042] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:45.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:43:0) after 1m0s
[07:45:45.062] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:43:0)
[07:45:45.062] Timer tick, asking Buildbucket for the build status
[07:45:45.209] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:45.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:44:0) after 1m0s
[07:46:45.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:44:0)
[07:46:45.262] Timer tick, asking Buildbucket for the build status
[07:46:45.335] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:45.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:45:0) after 1m0s
[07:47:45.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:45:0)
[07:47:45.352] Timer tick, asking Buildbucket for the build status
[07:47:45.413] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:45.413] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:46:0) after 1m0s
[07:48:45.444] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:46:0)
[07:48:45.444] Timer tick, asking Buildbucket for the build status
[07:48:45.521] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:45.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:47:0) after 1m0s
[07:49:45.586] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:47:0)
[07:49:45.587] Timer tick, asking Buildbucket for the build status
[07:49:45.676] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:45.676] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:48:0) after 1m0s
[07:50:45.767] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:48:0)
[07:50:45.767] Timer tick, asking Buildbucket for the build status
[07:50:45.931] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:45.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:49:0) after 1m0s
[07:51:45.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:49:0)
[07:51:45.977] Timer tick, asking Buildbucket for the build status
[07:51:46.350] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:46.350] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:50:0) after 1m0s
[07:52:46.409] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:50:0)
[07:52:46.409] Timer tick, asking Buildbucket for the build status
[07:52:46.482] Build 8853166121175546560: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:46.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9018596183114319200:51:0) after 1m0s
[07:53:17.208] Received PubSub notification, asking Buildbucket for the build status
[07:53:17.715] Build 8853166121175546560: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:53:17.715] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615362796156431",
"created_by": "project:chromium",
"created_ts": "1615359873564012",
"id": "8853166121175546560",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"075d29b4983b721ea92f39e7057c64f3f0a8a8df\"}}",
"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\": \"075d29b4983b721ea92f39e7057c64f3f0a8a8df\", \"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-58-lu8q\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 181261, \"got_angle_revision\": \"c054008f9efb2f86a0bd6b8031e8c635c69107e4\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"075d29b4983b721ea92f39e7057c64f3f0a8a8df\", \"got_revision_cp\": \"refs/heads/master@{#861453}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"8a7806552684dbddc1265f43895a37f02a6f3fed\", \"got_v8_revision_cp\": \"refs/heads/9.1.87@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"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\": \"075d29b4983b721ea92f39e7057c64f3f0a8a8df\", \"swarm_hashes_refs/heads/master(at){#861453}_without_patch\": {\"absl_hardening_tests\": \"f95d836901d1be6cbc3e898f70d4eab24813feb8\", \"accessibility_unittests\": \"1fe612851b8a56026a91354660fc5f58caf49053\", \"angle_unittests\": \"0006e5dc9edc4c0f84e498096d46f12520312e2c\", \"app_shell_unittests\": \"1b58686c92a2c0a442da8e98fdab86c9333d4d43\", \"aura_unittests\": \"a77f37da9a24ccbc3a6f544b0b5b1b119bfa3e10\", \"base_unittests\": \"f3a54bee0197d3af427d7fe70ccf8c5827312cd5\", \"base_util_unittests\": \"381d84440b0fe794f37bd43bfc5fc6043305f94a\", \"blink_common_unittests\": \"bfa175ccf71ced1e7e3409cbb1ae60a144e8bf63\", \"blink_fuzzer_unittests\": \"3c49474b5c7a30de05c2b08b2699e27c805454b2\", \"blink_heap_unittests\": \"d0221ffd4391100933abc3c92ba0d78b47c617b7\", \"blink_platform_unittests\": \"639bd4d363fb321f410be31d4acb9fad2e9ee0ae\", \"blink_python_tests\": \"09ff456d7cb96ba0fc66ad390019cf2210288adc\", \"blink_unittests\": \"71fc3b1fc1ea98e641dc08cb92d0c69afc5f8e21\", \"blink_web_tests\": \"f26564f0eef42ff2c2fdb8d925c51cf4f9cf1495\", \"boringssl_crypto_tests\": \"60c904e4e7de963b8e36e9f9dcdd9b402fa64598\", \"boringssl_ssl_tests\": \"eeb7e4b31fe4c21fe9cf74cebe9df997689d96bd\", \"browser_tests\": \"84d2e9bcba3b11b55f72c89cc275c8d7cec785de\", \"capture_unittests\": \"813d7d63f47f7f6ce94755f7474a4e691ff78163\", \"cast_unittests\": \"88faba1897dbfb6b6497aad28d9509dcc755d043\", \"cc_unittests\": \"6b6d6a65602c0d838819380aff8227febd99e02a\", \"chrome_app_unittests\": \"3b173fc447d66ccbd2ac5d8c3341130d68e8013f\", \"chromedriver_unittests\": \"a4f5f375321410f47fe0ca5f3f6391b7bf6b178e\", \"color_unittests\": \"b40decd5cf492367fab58fc2c771997b2ffe7b80\", \"components_browsertests\": \"7996422653449a4caf8d49672595aafd27b38f06\", \"components_unittests\": \"8790c2f690290a826e2a3b3906864c9d784551bb\", \"compositor_unittests\": \"8a48cc4167bd4b1d70f85aee6b901d953a44ca44\", \"content_browsertests\": \"4be86d980b7f316cd3cc827ac81977b68d5f3730\", \"content_shell_crash_test\": \"f0a4c22498022e355f8cec1f00f0d772f589d41e\", \"content_unittests\": \"4344d64efcbe4aa23e69039705162ecd9e2b426e\", \"crashpad_tests\": \"4c018bfb417592f9a3dbe31625b4da6cd91299db\", \"cronet_tests\": \"1425d232e3c84893eb335d76bd20774fa346677e\", \"cronet_unittests\": \"9d191519ab5edaf0e2b813d45e5dc9e77904e76f\", \"crypto_unittests\": \"171c0678af1b5e46ed932b0c1927ef50c13bae89\", \"dbus_unittests\": \"31cd2b8393c5e6adc98d4ea9683c39db6688bbaf\", \"device_unittests\": \"36d2413b3940b5e47cc8b308e5f85a6af72c74ee\", \"display_unittests\": \"1d8c042bb1d6e2cba01b9938fedc2456d27e6e03\", \"events_unittests\": \"0c97f8cce95fdab257a32c2c1c5e226b6e686212\", \"extensions_browsertests\": \"d90604a6dca72e8325f5754deb03f66b096bd0c9\", \"extensions_unittests\": \"37fcb63d8a125f1c8ba358dd23122d39f6e58db2\", \"filesystem_service_unittests\": \"3051657cfdab15142ea0cbc3b11098512077d4a0\", \"flatbuffers_unittests\": \"917c1926f9a03d6ef30fc9665ef3a1d956152ddf\", \"gcm_unit_tests\": \"1922c04d6a603d346d32966eb7813c636f132378\", \"gfx_unittests\": \"9279ef0f24c2c630693bb0b4c92073c5ec1300fb\", \"gin_unittests\": \"2f66f8fe287ad1806ca7fefd2caaf0f063594479\", \"google_apis_unittests\": \"3724e7ea9e3444da2d65e684de0c96aee74ebf20\", \"gpu_unittests\": \"fec3bb889d569de5cdff3d36be542e178e151a75\", \"grit_python_unittests\": \"2629172029a5ce27ead3b3791972502f1e7f17c8\", \"gwp_asan_unittests\": \"d297c3086553f2cee5a58a2542deab41588ccbdc\", \"headless_browsertests\": \"127440573f47094284ca1253a8a783d913c2eef2\", \"headless_unittests\": \"d7b05ec00e3fbc6ca9ff8ee2e3739a8edf156d9a\", \"interactive_ui_tests\": \"0d217fbd62c398b5a23b93eeaac9491913a097d5\", \"ipc_tests\": \"f88248dd06a9cffad276438b31094bfc0b9bde3a\", \"jingle_unittests\": \"f7bf170731236db015e436238bd3d9b22751d109\", \"latency_unittests\": \"92920a3ab3ad13888ba1c08fde6d438150bc2640\", \"libjingle_xmpp_unittests\": \"ca54ab45a83b85ab592d949c24d8bbb0d5991c39\", \"liburlpattern_unittests\": \"f27f3c3172ddac6b17fc531d33004f04eac2e34c\", \"media_blink_unittests\": \"6f79a3064adb86b22e837908d3165ea8be6ca4cf\", \"media_unittests\": \"c56b085d684eb7adfabba3df8bc20ea0744a7088\", \"message_center_unittests\": \"af8c990254687022147e4cb8fae38455fc6c5a98\", \"metrics_python_tests\": \"4b11916f1ab63ffa7cd08305dc0decf828d13f83\", \"midi_unittests\": \"2ae5c8f533d6e547f16350fb64c83d9285a5abb3\", \"mojo_core_unittests\": \"d518c7f751c3878eb4055a10ff7d70948c0ef8b5\", \"mojo_unittests\": \"5c3130f8f8bda75a2ca95f076bb079d683d807f4\", \"nacl_helper_nonsfi_unittests\": \"b81d1030cb9bc469305a8b2f83684627708521cc\", \"nacl_loader_unittests\": \"0eea2e98fa270e58922dfe0791fe7ced1f4c6c7b\", \"native_theme_unittests\": \"b46512d8a3759d28879f0aea5c5bc3c344e120aa\", \"net_unittests\": \"4938acd01731f8c9ab16688734761ec09371b3bd\", \"openscreen_unittests\": \"e71f29aff5f1a4f57233ada3b2c97741ab2d6ecf\", \"pdf_unittests\": \"5fda8861c914dab6f726d27ce0332c7a92f4fb87\", \"perfetto_unittests\": \"3ed5068a5f7367862c1e19cdd09d1fbee41d38a1\", \"ppapi_unittests\": \"6f3779df10320324fb9c371a878c740e0800696e\", \"printing_unittests\": \"1039846bf124e1205fe4598cb9663f6354b27690\", \"remoting_unittests\": \"e19f2215ac8132428e07c809f6a46d417c82f1b3\", \"sandbox_linux_unittests\": \"3b62f956d43e020f51ba44eb58a6001a34a33e8d\", \"service_manager_unittests\": \"4ecd83043797845ba981c2dc7d417624dee95040\", \"services_unittests\": \"b94babd8ab8e7c267f646a519e6d483a4af007f0\", \"shell_dialogs_unittests\": \"289db6dd9c9fb1b281538d73d74f12dfd4a9023c\", \"skia_unittests\": \"e8d88ef2149739cec522e707db3acd2392227c41\", \"snapshot_unittests\": \"e90d4afdea6cde17afb461c1c66a4228a4afbbed\", \"sql_unittests\": \"b76942a8361a9b80e16a1c97d8ce8b2107f6bb07\", \"storage_unittests\": \"cb19a871c6a4ed6b2937dc2fedead141264e3460\", \"sync_integration_tests\": \"1881278c7fa4728e1be7efbb773cd7de9cd80ad6\", \"telemetry_gpu_unittests\": \"2e6ba5d425bfee000b6f6bfb1fd5c701c6ad2704\", \"telemetry_perf_unittests\": \"9af6d43c45c4cb4bed4a6c597b1ac58b4840431e\", \"telemetry_unittests\": \"8c8f7faa18a468896d1e67f54400f5d8c1d24238\", \"traffic_annotation_auditor_unittests\": \"d43d6444aca9a1bbab0a6b39545fcbc21b3fded3\", \"ui_base_unittests\": \"1e5341c90f1b02593cf0b44c5e0c4bac85dbe7d9\", \"ui_touch_selection_unittests\": \"38abf1f594b4263541a5037fef507e2c9f9705a1\", \"unit_tests\": \"f18dd9b11052cb57e83b00035826aebbf23ffd3d\", \"url_unittests\": \"a82eee9b38b05464102b6305dcf1ce08e5027bed\", \"views_perftests\": \"3bf97e22479b72d71cb055f0d0f18e0ee8c0b6b6\", \"views_unittests\": \"2c2a32a5db85aeaf79a4bbeed5f3ffb9d8f75798\", \"viz_unittests\": \"c08987f9a38ca5e807127ea05f27ff71f53b4959\", \"vr_common_unittests\": \"2147d5b9f2e5668536401275a147e38ddf1c4539\", \"vr_pixeltests\": \"f227b294f9d3eabd216576ba9d57a747ed08f453\", \"webdriver_wpt_tests\": \"dc99fb6a10d7e4e84292f4f9cefe1051db9cc003\", \"weblayer_browsertests\": \"b4ba61f5253b2a5cd23db06bbdbd34bfe6bf0878\", \"weblayer_unittests\": \"28353a5e8bb4a3fecfd1978ba95792962bd5bb11\", \"wm_unittests\": \"15d686ae52ee3417dc828144c93c183dba8f86a9\", \"wtf_unittests\": \"4aea2fe375a0c14851729cd2e75f41fb6db5ce0f\", \"x11_unittests\": \"7d63a7e634ff00160702da05341505496692e97a\", \"xr_browser_tests\": \"9c0cd341c31d17f159df96b77ac3ba2a8906bfc5\", \"zlib_unittests\": \"f70e1fc2334144c906828f0fe509d1e51d158a15\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0b457c29832afe9869549a9d3fb1269d99c2cbc2ef2da9533a15fddd8d201757_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_994c6d057c4d72e6e60d1eac48ee38aafacc9bb85f78c7911d66463be69b94de_v2\", \"builder_abe2adbd32ad911c3e8d1f384e915329cf1f65e427edb6b91a9fbb61a55ed743_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-58-lu8q\"], \"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\": [\"5746-91ff3bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615359876124405",
"status": "COMPLETED",
"status_changed_ts": "1615362796524479",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181261",
"builder:Linux Builder (dbg)",
"buildset:commit/git/075d29b4983b721ea92f39e7057c64f3f0a8a8df",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/075d29b4983b721ea92f39e7057c64f3f0a8a8df",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018596183114319200",
"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/8853166121175546560/+/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:5233c51d33a8cb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615362796540434",
"url": "https://ci.chromium.org/b/8853166121175546560",
"utcnow_ts": "1615362797424654"
}
}
[07:53:17.715] Invocation finished in 48m45.382404639s with status SUCCEEDED