[13:47:31.500] New invocation is queued and will start shortly
[13:47:32.647] Starting the invocation (attempt 1)
[13:47:32.684] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:47:32.684] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:47:32.685] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028264704843103552",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"376d5802b75d0ae24bec0aa0db935adfc139b40a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9028264704843103552",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/376d5802b75d0ae24bec0aa0db935adfc139b40a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/376d5802b75d0ae24bec0aa0db935adfc139b40a",
"gitiles_ref:refs/heads/master"
]
}
[13:47:34.190] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606139253636664",
"id": "8862834641937526240",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"376d5802b75d0ae24bec0aa0db935adfc139b40a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606139254037453",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177944",
"builder:Linux Builder (dbg)",
"buildset:commit/git/376d5802b75d0ae24bec0aa0db935adfc139b40a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/376d5802b75d0ae24bec0aa0db935adfc139b40a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028264704843103552",
"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/8862834641937526240/+/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": "1606139254037626",
"url": "https://ci.chromium.org/b/8862834641937526240",
"utcnow_ts": "1606139254175032"
}
}
[13:47:34.190] Task URL: https://ci.chromium.org/b/8862834641937526240
[13:47:34.190] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:2:0) after 1m0s
[13:48:01.767] Received PubSub notification, asking Buildbucket for the build status
[13:48:01.848] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:34.223] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:2:0)
[13:48:34.223] Timer tick, asking Buildbucket for the build status
[13:48:34.324] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:34.324] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:4:0) after 1m0s
[13:49:34.382] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:4:0)
[13:49:34.382] Timer tick, asking Buildbucket for the build status
[13:49:34.490] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:34.490] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:5:0) after 1m0s
[13:50:34.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:5:0)
[13:50:34.516] Timer tick, asking Buildbucket for the build status
[13:50:34.583] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:34.583] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:6:0) after 1m0s
[13:51:34.625] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:6:0)
[13:51:34.625] Timer tick, asking Buildbucket for the build status
[13:51:34.698] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:34.698] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:7:0) after 1m0s
[13:52:34.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:7:0)
[13:52:34.722] Timer tick, asking Buildbucket for the build status
[13:52:34.820] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:34.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:8:0) after 1m0s
[13:53:34.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:8:0)
[13:53:34.871] Timer tick, asking Buildbucket for the build status
[13:53:34.961] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:34.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:9:0) after 1m0s
[13:54:35.015] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:9:0)
[13:54:35.015] Timer tick, asking Buildbucket for the build status
[13:54:35.134] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:35.134] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:10:0) after 1m0s
[13:55:35.250] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:10:0)
[13:55:35.250] Timer tick, asking Buildbucket for the build status
[13:55:35.468] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:35.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:11:0) after 1m0s
[13:56:35.536] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:11:0)
[13:56:35.536] Timer tick, asking Buildbucket for the build status
[13:56:35.616] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:35.616] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:12:0) after 1m0s
[13:57:35.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:12:0)
[13:57:35.685] Timer tick, asking Buildbucket for the build status
[13:57:36.715] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:36.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:13:0) after 1m0s
[13:58:36.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:13:0)
[13:58:36.803] Timer tick, asking Buildbucket for the build status
[13:58:36.934] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:36.935] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:14:0) after 1m0s
[13:59:37.019] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:14:0)
[13:59:37.019] Timer tick, asking Buildbucket for the build status
[13:59:37.089] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:37.089] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:15:0) after 1m0s
[14:00:37.143] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:15:0)
[14:00:37.143] Timer tick, asking Buildbucket for the build status
[14:00:37.289] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:37.289] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:16:0) after 1m0s
[14:01:37.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:16:0)
[14:01:37.339] Timer tick, asking Buildbucket for the build status
[14:01:37.434] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:37.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:17:0) after 1m0s
[14:02:37.458] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:17:0)
[14:02:37.458] Timer tick, asking Buildbucket for the build status
[14:02:37.825] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:37.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:18:0) after 1m0s
[14:03:37.863] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:18:0)
[14:03:37.863] Timer tick, asking Buildbucket for the build status
[14:03:37.935] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:37.935] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:19:0) after 1m0s
[14:04:37.974] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:19:0)
[14:04:37.974] Timer tick, asking Buildbucket for the build status
[14:04:38.066] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:38.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:20:0) after 1m0s
[14:05:38.150] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:20:0)
[14:05:38.150] Timer tick, asking Buildbucket for the build status
[14:05:38.204] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:38.204] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:21:0) after 1m0s
[14:06:38.310] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:21:0)
[14:06:38.310] Timer tick, asking Buildbucket for the build status
[14:06:38.384] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:38.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:22:0) after 1m0s
[14:07:38.399] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:22:0)
[14:07:38.400] Timer tick, asking Buildbucket for the build status
[14:07:38.641] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:38.641] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:23:0) after 1m0s
[14:08:38.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:23:0)
[14:08:38.706] Timer tick, asking Buildbucket for the build status
[14:08:38.790] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:38.790] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:24:0) after 1m0s
[14:09:39.032] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:24:0)
[14:09:39.032] Timer tick, asking Buildbucket for the build status
[14:09:39.312] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:39.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:25:0) after 1m0s
[14:10:39.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:25:0)
[14:10:39.405] Timer tick, asking Buildbucket for the build status
[14:10:39.463] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:39.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:26:0) after 1m0s
[14:11:39.504] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:26:0)
[14:11:39.504] Timer tick, asking Buildbucket for the build status
[14:11:39.797] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:39.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:27:0) after 1m0s
[14:12:39.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:27:0)
[14:12:39.806] Timer tick, asking Buildbucket for the build status
[14:12:39.913] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:39.913] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:28:0) after 1m0s
[14:13:39.970] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:28:0)
[14:13:39.970] Timer tick, asking Buildbucket for the build status
[14:13:40.032] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:40.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:29:0) after 1m0s
[14:14:40.061] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:29:0)
[14:14:40.061] Timer tick, asking Buildbucket for the build status
[14:14:40.127] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:40.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:30:0) after 1m0s
[14:15:40.168] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:30:0)
[14:15:40.168] Timer tick, asking Buildbucket for the build status
[14:15:40.233] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:40.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:31:0) after 1m0s
[14:16:40.255] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:31:0)
[14:16:40.255] Timer tick, asking Buildbucket for the build status
[14:16:40.318] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:40.318] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:32:0) after 1m0s
[14:17:40.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:32:0)
[14:17:40.459] Timer tick, asking Buildbucket for the build status
[14:17:40.572] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:40.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:33:0) after 1m0s
[14:18:40.653] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:33:0)
[14:18:40.653] Timer tick, asking Buildbucket for the build status
[14:18:40.721] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:40.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:34:0) after 1m0s
[14:19:40.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:34:0)
[14:19:40.809] Timer tick, asking Buildbucket for the build status
[14:19:40.872] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:40.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:35:0) after 1m0s
[14:20:40.902] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:35:0)
[14:20:40.902] Timer tick, asking Buildbucket for the build status
[14:20:41.053] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:41.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:36:0) after 1m0s
[14:21:41.122] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:36:0)
[14:21:41.122] Timer tick, asking Buildbucket for the build status
[14:21:41.200] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:41.200] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:37:0) after 1m0s
[14:22:41.258] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:37:0)
[14:22:41.258] Timer tick, asking Buildbucket for the build status
[14:22:41.383] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:41.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:38:0) after 1m0s
[14:23:41.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:38:0)
[14:23:41.461] Timer tick, asking Buildbucket for the build status
[14:23:41.628] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:41.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:39:0) after 1m0s
[14:24:41.667] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:39:0)
[14:24:41.667] Timer tick, asking Buildbucket for the build status
[14:24:41.831] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:41.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:40:0) after 1m0s
[14:25:41.883] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:40:0)
[14:25:41.883] Timer tick, asking Buildbucket for the build status
[14:25:42.156] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:42.156] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:41:0) after 1m0s
[14:26:42.222] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:41:0)
[14:26:42.223] Timer tick, asking Buildbucket for the build status
[14:26:42.278] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:42.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:42:0) after 1m0s
[14:27:42.298] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:42:0)
[14:27:42.298] Timer tick, asking Buildbucket for the build status
[14:27:42.393] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:42.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:43:0) after 1m0s
[14:28:42.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:43:0)
[14:28:42.417] Timer tick, asking Buildbucket for the build status
[14:28:42.550] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:42.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:44:0) after 1m0s
[14:29:42.654] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:44:0)
[14:29:42.654] Timer tick, asking Buildbucket for the build status
[14:29:42.714] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:42.714] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:45:0) after 1m0s
[14:30:42.839] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:45:0)
[14:30:42.839] Timer tick, asking Buildbucket for the build status
[14:30:43.034] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:43.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:46:0) after 1m0s
[14:31:43.104] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:46:0)
[14:31:43.104] Timer tick, asking Buildbucket for the build status
[14:31:43.196] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:43.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:47:0) after 1m0s
[14:32:43.196] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:47:0)
[14:32:43.196] Timer tick, asking Buildbucket for the build status
[14:32:43.284] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:43.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:48:0) after 1m0s
[14:33:43.411] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:48:0)
[14:33:43.411] Timer tick, asking Buildbucket for the build status
[14:33:43.481] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:43.481] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:49:0) after 1m0s
[14:34:43.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:49:0)
[14:34:43.511] Timer tick, asking Buildbucket for the build status
[14:34:43.578] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:43.578] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:50:0) after 1m0s
[14:35:43.649] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:50:0)
[14:35:43.649] Timer tick, asking Buildbucket for the build status
[14:35:43.736] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:43.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:51:0) after 1m0s
[14:36:43.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:51:0)
[14:36:43.833] Timer tick, asking Buildbucket for the build status
[14:36:43.931] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:43.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:52:0) after 1m0s
[14:37:44.003] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:52:0)
[14:37:44.003] Timer tick, asking Buildbucket for the build status
[14:37:44.151] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:44.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:53:0) after 1m0s
[14:38:44.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:53:0)
[14:38:44.208] Timer tick, asking Buildbucket for the build status
[14:38:44.537] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:44.537] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:54:0) after 1m0s
[14:39:44.679] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:54:0)
[14:39:44.679] Timer tick, asking Buildbucket for the build status
[14:39:44.754] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:44.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:55:0) after 1m0s
[14:40:44.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:55:0)
[14:40:44.918] Timer tick, asking Buildbucket for the build status
[14:40:44.978] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:44.978] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:56:0) after 1m0s
[14:41:45.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:56:0)
[14:41:45.072] Timer tick, asking Buildbucket for the build status
[14:41:45.317] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:45.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:57:0) after 1m0s
[14:42:45.385] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:57:0)
[14:42:45.385] Timer tick, asking Buildbucket for the build status
[14:42:45.787] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:45.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:58:0) after 1m0s
[14:43:45.849] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:58:0)
[14:43:45.849] Timer tick, asking Buildbucket for the build status
[14:43:45.918] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:45.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:59:0) after 1m0s
[14:44:45.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:59:0)
[14:44:45.939] Timer tick, asking Buildbucket for the build status
[14:44:48.135] Build 8862834641937526240: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:48.135] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028264704843103552:60:0) after 1m0s
[14:45:43.439] Received PubSub notification, asking Buildbucket for the build status
[14:45:44.172] Build 8862834641937526240: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:45:44.172] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606142742451271",
"created_by": "project:chromium",
"created_ts": "1606139253636664",
"id": "8862834641937526240",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"376d5802b75d0ae24bec0aa0db935adfc139b40a\"}}",
"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\": \"376d5802b75d0ae24bec0aa0db935adfc139b40a\", \"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-east1-d-8-28-k7q5\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177944, \"got_angle_revision\": \"9304577415d5b2cb7e34d357e7e20ab09f523bb0\", \"got_dawn_revision\": \"546a7c98c89718f2dadf1ae07088fa7cf2ccb53f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"376d5802b75d0ae24bec0aa0db935adfc139b40a\", \"got_revision_cp\": \"refs/heads/master@{#830163}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"6d612051c083238db89541be4fbb2d624a9baef4\", \"got_v8_revision\": \"847989b56465f5aadba45fd4f9c7a33b8d3692cc\", \"got_v8_revision_cp\": \"refs/heads/8.9.33@{#1}\", \"got_webrtc_revision\": \"79348b55df90f3f7d00f12fbc0c679cff147ba81\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32664}\", \"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\": \"376d5802b75d0ae24bec0aa0db935adfc139b40a\", \"swarm_hashes_refs/heads/master(at){#830163}_without_patch\": {\"absl_hardening_tests\": \"f12dc122b50a07c6de985aaffcfe782c432431e7\", \"accessibility_unittests\": \"f2f932f6f6759514f5a82ec6accdddbe93caf868\", \"angle_unittests\": \"fe6a77b23ad6391e9ab9077d9abd5333c343a791\", \"app_shell_unittests\": \"fd3e9fcc509e1d529450fe7ac2c4a5fd73ce0625\", \"aura_unittests\": \"5f44ad5084d4a234180bb67c4e4aeea11f539590\", \"base_unittests\": \"8875b4557f42708c53093d7caa0409a42f9bfe08\", \"base_util_unittests\": \"296c92fd41433f7bf097f4884a5463744c08a11c\", \"blink_common_unittests\": \"965580e691ee81b0fa7117c77ef4be08e84eeff5\", \"blink_fuzzer_unittests\": \"a3807bda1dedb846a530c6a9737185b122d885ed\", \"blink_heap_unittests\": \"f03059700816adc85f08d1778b11a870affdb8f8\", \"blink_platform_unittests\": \"ad6f63aeeea5d28e0861cd8d1c2d0768457b8e52\", \"blink_python_tests\": \"0138333a02843d1d669511bfe85ae30492ac514f\", \"blink_unittests\": \"739b34928f83b5c1dde02183d237ab3b87fbd868\", \"blink_web_tests\": \"c98818c7c68ec0dd71279525a337b5d6d731b59b\", \"boringssl_crypto_tests\": \"29245498ccafe5468a876d7751a9c0e52b0374ea\", \"boringssl_ssl_tests\": \"68354f92883962d69c37628143d2e62a1856a866\", \"browser_tests\": \"588f7e60d03b615b169cf1a1850d266c1c5df634\", \"capture_unittests\": \"7a15f70279b2ab46ce95806c2824015168548b12\", \"cast_unittests\": \"34be744f8a64a1db27e5d7f7da7f7b6fc018eaad\", \"cc_unittests\": \"2d3deb2e90afe9713a2dcbd521350101aff67d64\", \"chrome_app_unittests\": \"6ea38dbddb67dc1d3aa789f48f26d53424f205f2\", \"chromedriver_unittests\": \"5ff2fe3576d9cede4253250452d9e11d2711e585\", \"components_browsertests\": \"245a0409b3e61b194d37025a223ad05e438ab55f\", \"components_unittests\": \"f7114b701808c8a2f951177d81c148cdd32595f6\", \"compositor_unittests\": \"bcbcfc8b4f4b02ccb2ad6156201de03968469e81\", \"content_browsertests\": \"756da78b4bd3ddbc8cc7a8a2c207b00e6b632a9e\", \"content_shell_crash_test\": \"7ca65e6cabd1d1c0a21a4e31b0f1f02ac0112825\", \"content_unittests\": \"916df7e6537612715ab606a7b823103991d4aa9f\", \"crashpad_tests\": \"9987105d92b6a02ff715a79262c94d1e46acedc3\", \"cronet_tests\": \"ccdcba35bad52d80496871999ebc4f2ef4bc66fe\", \"cronet_unittests\": \"e2d24e74347411b4fe60356d4b6fd5f5d387e22e\", \"crypto_unittests\": \"1ae0e134593aa747f177f8026f7183203ae82639\", \"dbus_unittests\": \"11cd1fc6d8b5c45423ecaffd8d7f969fdcded73e\", \"device_unittests\": \"5da7e28539dc4cf94e71444d4e2a083d5b915cb1\", \"display_unittests\": \"6f06663a408aeceff3846f23ecfb9d3559398afa\", \"events_unittests\": \"2de93b7d63a62fcb13cdbdc7eceba6e6f6cb7278\", \"extension_docserver_python_unittests\": \"1ba7ea6e593c4a7e897ab3643408d21dc04f8c96\", \"extensions_browsertests\": \"f1c69ef512fbed99f8875a848b006ba6e53335dc\", \"extensions_unittests\": \"627ae5ea3f1cff1f448a11fd67ddab3d240dfb28\", \"filesystem_service_unittests\": \"c6c20cbe7b81a5b18c91fce6f28d88c98407551c\", \"flatbuffers_unittests\": \"dd6267ccaa5ef4f5de95507aa468128ed4c0a477\", \"gcm_unit_tests\": \"4a0729a7461c71d58b17e36e456e09d30e4b34eb\", \"gfx_unittests\": \"c7560d41b5acb23e9ed0f1ba51f8f8a73fd4e3a9\", \"gin_unittests\": \"9c397f0653cc9b16202448dce76ee8b3b72eaf11\", \"google_apis_unittests\": \"4cb7f27295902a88b6444b108b7fd2a0259baac5\", \"gpu_unittests\": \"d5aecf55755117af9bc75849bffe77ed17c06e09\", \"grit_python_unittests\": \"b20d4d77fd059e1da02f2886f0fe402b433cc81c\", \"gwp_asan_unittests\": \"af8d83c6f77d492cc358d4d1608458447d72b66e\", \"headless_browsertests\": \"e36414724535b35a25134471db1d2863b60245dd\", \"headless_unittests\": \"538c269f75d7957f02f1f26d4efa60a090c7dc7b\", \"interactive_ui_tests\": \"b0f2508b66bf02ac8d8479ea2f363f29c8c87e76\", \"ipc_tests\": \"7f8d0f7762edefb160b2eabbe3d0b8b2a56805f2\", \"jingle_unittests\": \"1964e4e76bbce0f981b52bfc5fdb47fcded57817\", \"latency_unittests\": \"762f961b14e581065505b6568d5a8d0899d93dbb\", \"libjingle_xmpp_unittests\": \"180584d16600fa9d1115e86d6f4751009dcd4e34\", \"liburlpattern_unittests\": \"3aab72cbf8756b0b302e426397978009800b2ad5\", \"media_blink_unittests\": \"ce495e73eeffb66b816984a3e72668a4f0a804dd\", \"media_unittests\": \"462d671818775fc8e2d75633de3a35a5d9a67bef\", \"message_center_unittests\": \"6577a8fde3bfb5c17a09f090557031f17fd4d3f5\", \"metrics_python_tests\": \"951bac29d1eb06343f33763d4735edc8ff37c36e\", \"midi_unittests\": \"3dc90075063e9a783ee1d42562b74813490b995d\", \"mojo_core_unittests\": \"1e8934a2ea2f031ebbd3f0096323c90aa326379b\", \"mojo_unittests\": \"901e73ba08339af2f4f7a567a85068e3af860287\", \"nacl_helper_nonsfi_unittests\": \"009beba0415d74049b6fb2edb7cc03c60fe2dffc\", \"nacl_loader_unittests\": \"710f7cc885552ed839355f4238af560c99c8514c\", \"native_theme_unittests\": \"779aaacb8677cf839d5c341ae50a8a94de48b526\", \"net_unittests\": \"f4bc54e53f9452fcfdcd701ea53ecc2d0d990829\", \"openscreen_unittests\": \"4ce03f438dfbb8b21a831a83d1b760b8b16cfc89\", \"pdf_unittests\": \"4d5043a1c5eebf0e7c4bf21f98d154b120f42f36\", \"perfetto_unittests\": \"a9959130a12195c7aab8f18fdcdbbecbf9078662\", \"ppapi_unittests\": \"fe6ffbbddf5d4fbff2b31d43fe3ee87f99115e78\", \"printing_unittests\": \"bcd3e529bba8ded7b3c929b964775a365aa1d282\", \"remoting_unittests\": \"4e93fea06dc4fc016213927b6fb674aedb8e7230\", \"sandbox_linux_unittests\": \"453d8d37cc19a974b01ae5880c4384b17c2fc39c\", \"service_manager_unittests\": \"04fb645850284c7aec327645df16d3c6d12d9008\", \"services_unittests\": \"084dd2575ecc5895b5d66ab4a597eeb4f13a9535\", \"shell_dialogs_unittests\": \"3398a106ee4e0bd60efa0be98fef28ae3b638e19\", \"skia_unittests\": \"57469eb8eff4a960b1dd0b7f0d8ba473f1feadfe\", \"snapshot_unittests\": \"74ab145de0ff3870593cff8b98d9e233779cd9c8\", \"sql_unittests\": \"4b4195f63808549e95f07882a4fe64641758e284\", \"storage_unittests\": \"c29e8fe6e99ae5ac98befa656a173fe6f2aab7fa\", \"sync_integration_tests\": \"3f8c8436fd68d08d359c03e57b1dbaf783dcbee4\", \"telemetry_gpu_unittests\": \"046b39b7274b07dadacc99f568620fa9c4f159be\", \"telemetry_perf_unittests\": \"2a254abf9105d0f37dc936cac73b5a4f6de29263\", \"telemetry_unittests\": \"9b0ddd8fa18308566ed2335e7cf9eceb8fa11f4f\", \"traffic_annotation_auditor_unittests\": \"048988d2efe5a79633cf9665ee4cb970a43a24fb\", \"ui_base_unittests\": \"1deee06f92bbd14c478a488952f6f4ef65d22387\", \"ui_touch_selection_unittests\": \"2fdb70f4f707015b229260819138a414f8acae79\", \"unit_tests\": \"faed48472b62bb944a4dafcc9313c66b42f216da\", \"url_unittests\": \"bf752a6f30797c24f6378813add680fa9708040c\", \"views_perftests\": \"4bd62f3cb8f295274ff65997009c6670beba6a76\", \"views_unittests\": \"0d56f32165d21862cc2dfd489db5f1667ee97296\", \"viz_unittests\": \"3223133e8ebd52d9267d58573beb0f64e6f009f9\", \"vr_common_unittests\": \"6ecaedfc0589ee1ac6d3b044075891444a927170\", \"vr_pixeltests\": \"69ccd3b9e3c40c0abda2ed19812c07278a11e606\", \"webdriver_wpt_tests\": \"c9199ed3dcf9c0bd79053cecce967392457bb170\", \"weblayer_browsertests\": \"fa4a67733c7e10679bc4d922357a6ea8c68b8530\", \"weblayer_unittests\": \"90ae81517ebd27af9544d68b660f0cbba09c7fdc\", \"wm_unittests\": \"0d43effdcf3c7f7210fc42e2f91f06e94a37b38c\", \"wtf_unittests\": \"e93f75e67356ffdd212d593ece93306cda5c9d4e\", \"x11_unittests\": \"8b2df4fed4a1e205fcdfe84e91c4fccd00b3cd16\", \"xr_browser_tests\": \"1d229a4054394802bfa29f48716116ee4a94bdc5\", \"zlib_unittests\": \"116583679026d10248c2534663dedc7faa9698da\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a68a9f55474b9b0de9a1b5508ecffb4a5d0899362fc191acd472d4c557fdb4e8_v2\", \"builder_b347f6763adaa44ed1b4895a094f35f1b15f20643e3eba38abfdc8f27ff2117b_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_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-east1-d-8-28-k7q5\"], \"image\": [\"chrome-xenial-20111600-a937a23cefb\"], \"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\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606139280815019",
"status": "COMPLETED",
"status_changed_ts": "1606142742892189",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177944",
"builder:Linux Builder (dbg)",
"buildset:commit/git/376d5802b75d0ae24bec0aa0db935adfc139b40a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/376d5802b75d0ae24bec0aa0db935adfc139b40a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028264704843103552",
"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/8862834641937526240/+/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:500e2d9f793f5010",
"user_agent:luci-scheduler"
],
"updated_ts": "1606142742935055",
"url": "https://ci.chromium.org/b/8862834641937526240",
"utcnow_ts": "1606142743876699"
}
}
[14:45:44.172] Invocation finished in 58m12.690064098s with status SUCCEEDED