[01:37:22.946] New invocation is queued and will start shortly
[01:37:24.201] Starting the invocation (attempt 1)
[01:37:24.260] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:37:24.260] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:37:24.260] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019975720528147120",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7aa3e0879b43b9b3c2faa3d72b063595d809c992\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9019975720528147120",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/7aa3e0879b43b9b3c2faa3d72b063595d809c992",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7aa3e0879b43b9b3c2faa3d72b063595d809c992",
"gitiles_ref:refs/heads/master"
]
}
[01:37:25.786] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614044244466481",
"id": "8854545658273470528",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7aa3e0879b43b9b3c2faa3d72b063595d809c992\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614044245474636",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180833",
"builder:Linux Builder (dbg)",
"buildset:commit/git/7aa3e0879b43b9b3c2faa3d72b063595d809c992",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7aa3e0879b43b9b3c2faa3d72b063595d809c992",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019975720528147120",
"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/8854545658273470528/+/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": "1614044245474997",
"url": "https://ci.chromium.org/b/8854545658273470528",
"utcnow_ts": "1614044245775175"
}
}
[01:37:25.787] Task URL: https://ci.chromium.org/b/8854545658273470528
[01:37:25.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:2:0) after 1m0s
[01:37:30.445] Received PubSub notification, asking Buildbucket for the build status
[01:37:30.702] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:25.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:2:0)
[01:38:25.801] Timer tick, asking Buildbucket for the build status
[01:38:25.893] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:25.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:4:0) after 1m0s
[01:39:25.928] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:4:0)
[01:39:25.928] Timer tick, asking Buildbucket for the build status
[01:39:26.051] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:26.051] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:5:0) after 1m0s
[01:40:26.024] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:5:0)
[01:40:26.024] Timer tick, asking Buildbucket for the build status
[01:40:26.953] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:26.953] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:6:0) after 1m0s
[01:41:27.111] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:6:0)
[01:41:27.111] Timer tick, asking Buildbucket for the build status
[01:41:27.222] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:27.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:7:0) after 1m0s
[01:42:27.294] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:7:0)
[01:42:27.294] Timer tick, asking Buildbucket for the build status
[01:42:27.384] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:27.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:8:0) after 1m0s
[01:43:27.466] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:8:0)
[01:43:27.466] Timer tick, asking Buildbucket for the build status
[01:43:27.613] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:27.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:9:0) after 1m0s
[01:44:27.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:9:0)
[01:44:27.685] Timer tick, asking Buildbucket for the build status
[01:44:27.796] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:27.796] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:10:0) after 1m0s
[01:45:27.813] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:10:0)
[01:45:27.813] Timer tick, asking Buildbucket for the build status
[01:45:27.897] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:27.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:11:0) after 1m0s
[01:46:27.985] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:11:0)
[01:46:27.985] Timer tick, asking Buildbucket for the build status
[01:46:28.156] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:28.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:12:0) after 1m0s
[01:47:28.275] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:12:0)
[01:47:28.275] Timer tick, asking Buildbucket for the build status
[01:47:28.468] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:28.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:13:0) after 1m0s
[01:48:28.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:13:0)
[01:48:28.484] Timer tick, asking Buildbucket for the build status
[01:48:28.554] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:28.554] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:14:0) after 1m0s
[01:49:28.569] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:14:0)
[01:49:28.569] Timer tick, asking Buildbucket for the build status
[01:49:28.827] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:28.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:15:0) after 1m0s
[01:50:28.842] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:15:0)
[01:50:28.842] Timer tick, asking Buildbucket for the build status
[01:50:28.979] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:28.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:16:0) after 1m0s
[01:51:29.064] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:16:0)
[01:51:29.064] Timer tick, asking Buildbucket for the build status
[01:51:29.152] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:29.152] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:17:0) after 1m0s
[01:52:29.145] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:17:0)
[01:52:29.145] Timer tick, asking Buildbucket for the build status
[01:52:29.260] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:29.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:18:0) after 1m0s
[01:53:29.286] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:18:0)
[01:53:29.286] Timer tick, asking Buildbucket for the build status
[01:53:29.354] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:29.354] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:19:0) after 1m0s
[01:54:29.435] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:19:0)
[01:54:29.435] Timer tick, asking Buildbucket for the build status
[01:54:29.509] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:29.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:20:0) after 1m0s
[01:55:29.574] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:20:0)
[01:55:29.574] Timer tick, asking Buildbucket for the build status
[01:55:29.650] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:29.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:21:0) after 1m0s
[01:56:29.731] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:21:0)
[01:56:29.731] Timer tick, asking Buildbucket for the build status
[01:56:29.813] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:29.813] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:22:0) after 1m0s
[01:57:29.854] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:22:0)
[01:57:29.854] Timer tick, asking Buildbucket for the build status
[01:57:29.967] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:29.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:23:0) after 1m0s
[01:58:30.058] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:23:0)
[01:58:30.058] Timer tick, asking Buildbucket for the build status
[01:58:30.225] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:30.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:24:0) after 1m0s
[01:59:30.245] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:24:0)
[01:59:30.245] Timer tick, asking Buildbucket for the build status
[01:59:30.354] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:30.354] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:25:0) after 1m0s
[02:00:30.404] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:25:0)
[02:00:30.404] Timer tick, asking Buildbucket for the build status
[02:00:30.498] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:30.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:26:0) after 1m0s
[02:01:30.587] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:26:0)
[02:01:30.587] Timer tick, asking Buildbucket for the build status
[02:01:30.703] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:30.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:27:0) after 1m0s
[02:02:30.713] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:27:0)
[02:02:30.713] Timer tick, asking Buildbucket for the build status
[02:02:30.900] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:30.900] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:28:0) after 1m0s
[02:03:30.959] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:28:0)
[02:03:30.959] Timer tick, asking Buildbucket for the build status
[02:03:31.191] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:31.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:29:0) after 1m0s
[02:04:31.219] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:29:0)
[02:04:31.219] Timer tick, asking Buildbucket for the build status
[02:04:31.439] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:31.439] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:30:0) after 1m0s
[02:05:31.504] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:30:0)
[02:05:31.504] Timer tick, asking Buildbucket for the build status
[02:05:31.730] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:31.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:31:0) after 1m0s
[02:06:31.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:31:0)
[02:06:31.821] Timer tick, asking Buildbucket for the build status
[02:06:32.188] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:32.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:32:0) after 1m0s
[02:07:32.282] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:32:0)
[02:07:32.282] Timer tick, asking Buildbucket for the build status
[02:07:32.430] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:32.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:33:0) after 1m0s
[02:08:32.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:33:0)
[02:08:32.437] Timer tick, asking Buildbucket for the build status
[02:08:32.521] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:32.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:34:0) after 1m0s
[02:09:32.583] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:34:0)
[02:09:32.583] Timer tick, asking Buildbucket for the build status
[02:09:32.854] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:32.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:35:0) after 1m0s
[02:10:32.879] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:35:0)
[02:10:32.879] Timer tick, asking Buildbucket for the build status
[02:10:32.956] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:32.956] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:36:0) after 1m0s
[02:11:32.980] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:36:0)
[02:11:32.980] Timer tick, asking Buildbucket for the build status
[02:11:33.060] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:33.060] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:37:0) after 1m0s
[02:12:33.216] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:37:0)
[02:12:33.216] Timer tick, asking Buildbucket for the build status
[02:12:33.557] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:33.557] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:38:0) after 1m0s
[02:13:33.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:38:0)
[02:13:33.600] Timer tick, asking Buildbucket for the build status
[02:13:33.675] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:33.675] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:39:0) after 1m0s
[02:14:33.790] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:39:0)
[02:14:33.790] Timer tick, asking Buildbucket for the build status
[02:14:33.868] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:33.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:40:0) after 1m0s
[02:15:33.870] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:40:0)
[02:15:33.870] Timer tick, asking Buildbucket for the build status
[02:15:34.070] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:34.070] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:41:0) after 1m0s
[02:16:34.176] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:41:0)
[02:16:34.176] Timer tick, asking Buildbucket for the build status
[02:16:34.294] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:34.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:42:0) after 1m0s
[02:17:34.336] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:42:0)
[02:17:34.336] Timer tick, asking Buildbucket for the build status
[02:17:34.435] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:34.435] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:43:0) after 1m0s
[02:18:34.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:43:0)
[02:18:34.568] Timer tick, asking Buildbucket for the build status
[02:18:34.799] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:34.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:44:0) after 1m0s
[02:19:34.818] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:44:0)
[02:19:34.818] Timer tick, asking Buildbucket for the build status
[02:19:34.897] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:34.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:45:0) after 1m0s
[02:20:35.067] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:45:0)
[02:20:35.067] Timer tick, asking Buildbucket for the build status
[02:20:35.143] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:35.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:46:0) after 1m0s
[02:21:35.157] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:46:0)
[02:21:35.157] Timer tick, asking Buildbucket for the build status
[02:21:35.249] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:35.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:47:0) after 1m0s
[02:22:35.333] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:47:0)
[02:22:35.333] Timer tick, asking Buildbucket for the build status
[02:22:35.525] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:35.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:48:0) after 1m0s
[02:23:35.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:48:0)
[02:23:35.548] Timer tick, asking Buildbucket for the build status
[02:23:35.731] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:35.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:49:0) after 1m0s
[02:24:35.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:49:0)
[02:24:35.806] Timer tick, asking Buildbucket for the build status
[02:24:37.918] Build 8854545658273470528: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:37.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019975720528147120:50:0) after 1m0s
[02:24:53.549] Received PubSub notification, asking Buildbucket for the build status
[02:24:53.642] Build 8854545658273470528: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:24:53.642] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614047093029985",
"created_by": "project:chromium",
"created_ts": "1614044244466481",
"id": "8854545658273470528",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7aa3e0879b43b9b3c2faa3d72b063595d809c992\"}}",
"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\": \"7aa3e0879b43b9b3c2faa3d72b063595d809c992\", \"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-8-4egf\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180833, \"got_angle_revision\": \"4a95488c0edfb4590c808ee01079069da5a6b2b1\", \"got_dawn_revision\": \"2d3c2e355337037dfa6873536bfb3e3a558bf9ed\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"7aa3e0879b43b9b3c2faa3d72b063595d809c992\", \"got_revision_cp\": \"refs/heads/master@{#856548}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"22186f076bf3bbe1a818792bde93b297e3773f7e\", \"got_v8_revision\": \"4120b5f2509821e8dd460b1d033708397520750a\", \"got_v8_revision_cp\": \"refs/heads/9.0.238@{#1}\", \"got_webrtc_revision\": \"6fe3fa14c6686ba9c51095b97ad2e6833a9b03e5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33319}\", \"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\": \"7aa3e0879b43b9b3c2faa3d72b063595d809c992\", \"swarm_hashes_refs/heads/master(at){#856548}_without_patch\": {\"absl_hardening_tests\": \"09ae2a61f97706c81a0112e9f297f8d1beddf6fe\", \"accessibility_unittests\": \"4db9986561997fd1107c1dd918fb803760fda0fd\", \"angle_unittests\": \"cb4b115c6cd4c5313d4086a4a71ee9c475e9a87f\", \"app_shell_unittests\": \"2b05a99c007f2fe0f612f1b9f8468ac3fea2be1d\", \"aura_unittests\": \"dbf2395d4602e9ab26af8b4b05ec015b3c3db66b\", \"base_unittests\": \"c78e092cc7ee4760e7c88edface8c3a67b4b0027\", \"base_util_unittests\": \"07f0c7fc72c1723e6b7403d976977398b29aff04\", \"blink_common_unittests\": \"21529a1a3a92fe4a2373aab78e5f1e41a4657b8b\", \"blink_fuzzer_unittests\": \"b73c80e12acddf6679dd47074fd4414d62243010\", \"blink_heap_unittests\": \"83c5bff703dce54b9966764093b5586c7b741711\", \"blink_platform_unittests\": \"96a9b7901f05895e6b48d83eed5493b197419316\", \"blink_python_tests\": \"5c70098189ed7f3a0528188e3aef2f962e00e1dd\", \"blink_unittests\": \"06cdd5cb6f0056d900192e1a04adc21898504b64\", \"blink_web_tests\": \"b834a43144176ccb751c4f3ce8382424b07eecc6\", \"boringssl_crypto_tests\": \"4f0d01cc4131157f91c5ee7b557a62228495402e\", \"boringssl_ssl_tests\": \"554a160bf84a6e15c77590296a4dc3903bc5f6c8\", \"browser_tests\": \"fb3d3cae7bd777cb4fd64cab1159d25a1568528e\", \"capture_unittests\": \"8c168e3e5615223c3142f767cc6e4d554c289428\", \"cast_unittests\": \"55b89654a7e65584116c020468b0737a5284b27f\", \"cc_unittests\": \"5850ac40195e48f0579964426abf5eb6f5b7d527\", \"chrome_app_unittests\": \"034f6a7dbf93ce54f89d090190c29d16d715bd9b\", \"chromedriver_unittests\": \"4d6527f51fdc4016a5b04596799886be901731c6\", \"components_browsertests\": \"252d8e97290c84178d2296212642dfc521876b32\", \"components_unittests\": \"89fbeb6c8674a84921d940e942f421abd1ec0a72\", \"compositor_unittests\": \"90b0d1b4b91229223e5d6c1ea8c27f98c378823b\", \"content_browsertests\": \"5ad3a24876b79589887a2f70f393fb307255c93b\", \"content_shell_crash_test\": \"eb61af619a786f48be24026255a2efb23dc2d035\", \"content_unittests\": \"ae588e94e38ef41fb30606edcdd41f8b13a5a022\", \"crashpad_tests\": \"db1398e44886c55ac4a99749e43186b13ea3d762\", \"cronet_tests\": \"54a0f81b3e0f0964bddf40f398d739ce2483f2e1\", \"cronet_unittests\": \"5271fc5485a07110bef0d355449e283a5ed667bf\", \"crypto_unittests\": \"4b60ffa348c35e4efd75576511818acf7ae63e84\", \"dbus_unittests\": \"0f2724c8d78e89e3ca0c6e4c5f490c8d8811df0f\", \"device_unittests\": \"135b088d0ffd1662a649eb9e9fc58ae4e08c7517\", \"display_unittests\": \"86550f27692fa71b71c2e9524b6c510947a8ab5a\", \"events_unittests\": \"2eefb220698283a1bcdb1eddce50fca13393079b\", \"extensions_browsertests\": \"de5550bc904dd91f647ef5153f39e149b5abaf58\", \"extensions_unittests\": \"4cc6ace85f66f9b9be871578c10b04ab4a891d01\", \"filesystem_service_unittests\": \"4295b14b8f898cc0e9d66e3e0aea33f66b67b5aa\", \"flatbuffers_unittests\": \"698230cd2ee29799b3293b30c69cdc80b3ff243d\", \"gcm_unit_tests\": \"2a2cb3972c100517109141c12bcf47a8dd80b1fe\", \"gfx_unittests\": \"d790f5c80273ecfd01e35de9b730accb668772ea\", \"gin_unittests\": \"9ee30a8ea993abda0a2b4054429a3b0ce572c305\", \"google_apis_unittests\": \"89a81e2025bc7b130bdc448a6381aa31d744d6fd\", \"gpu_unittests\": \"d1e967981c28bffd8406db920d5a22baf140f125\", \"grit_python_unittests\": \"e9472d6ec31317123f3dfff9be51bd5eb8f9349b\", \"gwp_asan_unittests\": \"f55256ae2b33a809cfccadb33f3ca00820f5bf49\", \"headless_browsertests\": \"7fb8906c0a93c3210644f8408892b537847353eb\", \"headless_unittests\": \"f34691eca32c44751fbae3ff9815e7985f27b8ac\", \"interactive_ui_tests\": \"c766a28fdd9847738f36cbdd504bf41a7a853579\", \"ipc_tests\": \"966d0081dde14bf1e2358160083a68cf4674fb85\", \"jingle_unittests\": \"86dbe7e7c29305854afcade2154664b648a1fee7\", \"latency_unittests\": \"8b32df43bcf2acd1ae342ac433cc2eef31fd7131\", \"libjingle_xmpp_unittests\": \"17f69ea26b3c1c911d9862452c3be023365112d1\", \"liburlpattern_unittests\": \"c1a174f902482998497985bf05ac3e7c766fe98e\", \"media_blink_unittests\": \"dfc1d830a6aec40aac9f5acf8791f8692eb78ab9\", \"media_unittests\": \"6d14bc86cecb6f510d9fb2b9caa97ee413a4a762\", \"message_center_unittests\": \"d4acf71d3e9a6a8c4e271435892a49df83d1d957\", \"metrics_python_tests\": \"4c55d66c38b3bea64f4476bff163d1359d1626ac\", \"midi_unittests\": \"c3c05b0a967ced8b36d935265bbc63a872e0a0d0\", \"mojo_core_unittests\": \"eb88373c5a38f2494c19b1752f4088f807aeed04\", \"mojo_unittests\": \"29e7906e82a3f108c4b905712b5afbcf4fe259cc\", \"nacl_helper_nonsfi_unittests\": \"66018e0c144db5bb32d838565c8a32bed949be34\", \"nacl_loader_unittests\": \"e7f7e3a0ad7cc670d2a01082e274f8c5d7e62191\", \"native_theme_unittests\": \"c9cbec5343e9c739abc3bd282e4d6ac37eb296a5\", \"net_unittests\": \"6f404974de03a8592682d2fc6e012c571619e5de\", \"openscreen_unittests\": \"e5d89613310e5d60748e53026ddf73a1c25892d4\", \"pdf_unittests\": \"3e934fa533a9a4f967d3ef58265f24087f973746\", \"perfetto_unittests\": \"1d84a4077d9e912870d5a2f065eacc9d4f48d699\", \"ppapi_unittests\": \"0d8ff91b72674a00c36917eb3891fb1068aa9da4\", \"printing_unittests\": \"69aab2d4da107e848c3ef88a177ab4a9759026ba\", \"remoting_unittests\": \"8d480207499328286aa1c189b5bd4999ec5b12e9\", \"sandbox_linux_unittests\": \"d61dbede31212ec08d5301017a125089138f19a3\", \"service_manager_unittests\": \"0efde620bc81352ecf5c59f1c9ab10dcb581909e\", \"services_unittests\": \"45c0578e0aeef5857f10014cac5c40157612866e\", \"shell_dialogs_unittests\": \"76aadf6bb0d558fc54c9217f0975a52f036bf75c\", \"skia_unittests\": \"becc9fcbc525865107c2daea97f2ab4ac6cb7956\", \"snapshot_unittests\": \"d7d371584347b9d04575642781708e0891a4d329\", \"sql_unittests\": \"de44d91f34a66a39e165f2c1e1297a30956ec18e\", \"storage_unittests\": \"d3c8e7c479dab98f859129c5fda135bce03e5095\", \"sync_integration_tests\": \"1abceb8265e100a2b94381b4a388bafaa41a21b3\", \"telemetry_gpu_unittests\": \"67254fb5f9fabb81b9de9937856f86f08dd3132a\", \"telemetry_perf_unittests\": \"00786bbba09c33bd7f236d608e17b2dda8d5b93d\", \"telemetry_unittests\": \"6e458a294920f4f8c7473e804a15fe90daac325e\", \"traffic_annotation_auditor_unittests\": \"974e481c4f26499ea8f02afb9de5a17309908091\", \"ui_base_unittests\": \"e88d352fa3ceb8647080555a0b4f07fb3f42abf8\", \"ui_touch_selection_unittests\": \"3f10088d0df8165f2cf2235ee7d6ce3f9d830f2f\", \"unit_tests\": \"0f39e45f7204d511949643e237fae0ccb4fdbcac\", \"url_unittests\": \"c590f817a8e8b0ee79f12c589cc8322aca854518\", \"views_perftests\": \"2ed53d2760350a7a7d3d06ef36149590dc33afa6\", \"views_unittests\": \"5c093dbfe97d3e0c71d605c08f98e290e874eb7c\", \"viz_unittests\": \"172e885635b1f884df19325b163f95d4895ad137\", \"vr_common_unittests\": \"35b468e4061aa779d1297c57e3c0e881e5e05173\", \"vr_pixeltests\": \"e26394bcdd3ec8e097b59d43b8b50153b0777bee\", \"webdriver_wpt_tests\": \"12652b85db1ed1f8c548e72685a9d875c6f1f1d0\", \"weblayer_browsertests\": \"563c8c25f9bd8e83a6bc1a0ee96403c68c0aae4f\", \"weblayer_unittests\": \"46ff52ac7de7551d47657e05428230f41eb14786\", \"wm_unittests\": \"ccacc3bfba8989f8df6d0e44e7c84fd53f7cbb62\", \"wtf_unittests\": \"c42879251c4ae196afc50e926a9f46fbe068f4fd\", \"x11_unittests\": \"9847195c26cccf035cf6a9fcf998fee3338c72c0\", \"xr_browser_tests\": \"e54454e7ae56b3b9db8248ef1ae15eef0d27e9e8\", \"zlib_unittests\": \"adf4e2445095ab6f17986f14c8a4b99a871a9bd2\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093d924ecb526dae9a1dcf9db4725f8944eec2b4c0f2ddc6c2ac4a04802f7f15_v2\", \"builder_361cbaa79261c75a92fc63a8f8c6fc117764238b3277286fa51086e6da3301df_v2\", \"builder_414309451a62452c5fc91088f02bc2b3c7255663a128fe9787a2b8d2a76dca13_v2\", \"builder_8da721b663411a8949c2bab4d98f074519f5dacc98d2381d19d66b38dd85adce_v2\", \"builder_9abb531f9fa28fcfd3ce68b2370bf6d67201ddb083beddbd2671f7c5fe25be9e_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-8-4egf\"], \"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": "1614044249540985",
"status": "COMPLETED",
"status_changed_ts": "1614047093319690",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180833",
"builder:Linux Builder (dbg)",
"buildset:commit/git/7aa3e0879b43b9b3c2faa3d72b063595d809c992",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7aa3e0879b43b9b3c2faa3d72b063595d809c992",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019975720528147120",
"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/8854545658273470528/+/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:51e55a39ed36df10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614047093324160",
"url": "https://ci.chromium.org/b/8854545658273470528",
"utcnow_ts": "1614047093634954"
}
}
[02:24:53.642] Invocation finished in 47m30.710172946s with status SUCCEEDED