[09:58:32.314] New invocation is queued and will start shortly
[09:58:33.735] Starting the invocation (attempt 1)
[09:58:33.772] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:58:33.772] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:58:33.772] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9032446571879336720",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e835ae293245dffd912a0a95423e6187c16bb9f0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9032446571879336720",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/e835ae293245dffd912a0a95423e6187c16bb9f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e835ae293245dffd912a0a95423e6187c16bb9f0",
"gitiles_ref:refs/heads/master"
]
}
[09:58:34.370] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602151113884266",
"id": "8867016509566234016",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e835ae293245dffd912a0a95423e6187c16bb9f0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602151114231598",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176455",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e835ae293245dffd912a0a95423e6187c16bb9f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e835ae293245dffd912a0a95423e6187c16bb9f0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032446571879336720",
"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/8867016509566234016/+/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": "1602151114231709",
"url": "https://ci.chromium.org/b/8867016509566234016",
"utcnow_ts": "1602151114361309"
}
}
[09:58:34.370] Task URL: https://ci.chromium.org/b/8867016509566234016
[09:58:34.370] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:2:0) after 1m0s
[09:59:34.491] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:2:0)
[09:59:34.491] Timer tick, asking Buildbucket for the build status
[09:59:34.580] Build 8867016509566234016: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:59:34.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:3:0) after 1m0s
[10:00:34.699] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:3:0)
[10:00:34.699] Timer tick, asking Buildbucket for the build status
[10:00:34.811] Build 8867016509566234016: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:00:34.811] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:4:0) after 1m0s
[10:01:34.887] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:4:0)
[10:01:34.887] Timer tick, asking Buildbucket for the build status
[10:01:34.956] Build 8867016509566234016: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:01:34.956] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:5:0) after 1m0s
[10:02:35.020] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:5:0)
[10:02:35.020] Timer tick, asking Buildbucket for the build status
[10:02:35.396] Build 8867016509566234016: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:02:35.396] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:6:0) after 1m0s
[10:02:38.253] Received PubSub notification, asking Buildbucket for the build status
[10:02:38.333] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:35.625] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:6:0)
[10:03:35.625] Timer tick, asking Buildbucket for the build status
[10:03:35.744] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:35.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:8:0) after 1m0s
[10:04:35.883] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:8:0)
[10:04:35.883] Timer tick, asking Buildbucket for the build status
[10:04:36.125] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:36.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:9:0) after 1m0s
[10:05:36.179] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:9:0)
[10:05:36.179] Timer tick, asking Buildbucket for the build status
[10:05:36.236] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:36.236] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:10:0) after 1m0s
[10:06:36.303] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:10:0)
[10:06:36.303] Timer tick, asking Buildbucket for the build status
[10:06:36.724] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:36.724] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:11:0) after 1m0s
[10:07:36.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:11:0)
[10:07:36.885] Timer tick, asking Buildbucket for the build status
[10:07:36.989] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:36.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:12:0) after 1m0s
[10:08:37.070] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:12:0)
[10:08:37.070] Timer tick, asking Buildbucket for the build status
[10:08:37.165] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:37.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:13:0) after 1m0s
[10:09:37.253] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:13:0)
[10:09:37.253] Timer tick, asking Buildbucket for the build status
[10:09:37.322] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:37.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:14:0) after 1m0s
[10:10:37.369] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:14:0)
[10:10:37.369] Timer tick, asking Buildbucket for the build status
[10:10:37.421] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:37.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:15:0) after 1m0s
[10:11:37.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:15:0)
[10:11:37.526] Timer tick, asking Buildbucket for the build status
[10:11:37.700] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:37.700] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:16:0) after 1m0s
[10:12:37.688] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:16:0)
[10:12:37.688] Timer tick, asking Buildbucket for the build status
[10:12:37.980] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:37.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:17:0) after 1m0s
[10:13:37.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:17:0)
[10:13:37.963] Timer tick, asking Buildbucket for the build status
[10:13:38.394] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:38.394] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:18:0) after 1m0s
[10:14:38.490] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:18:0)
[10:14:38.490] Timer tick, asking Buildbucket for the build status
[10:14:38.555] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:38.555] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:19:0) after 1m0s
[10:15:38.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:19:0)
[10:15:38.576] Timer tick, asking Buildbucket for the build status
[10:15:38.644] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:38.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:20:0) after 1m0s
[10:16:38.684] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:20:0)
[10:16:38.684] Timer tick, asking Buildbucket for the build status
[10:16:38.749] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:38.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:21:0) after 1m0s
[10:17:38.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:21:0)
[10:17:38.792] Timer tick, asking Buildbucket for the build status
[10:17:38.893] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:38.893] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:22:0) after 1m0s
[10:18:38.971] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:22:0)
[10:18:38.971] Timer tick, asking Buildbucket for the build status
[10:18:39.075] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:39.075] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:23:0) after 1m0s
[10:19:39.139] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:23:0)
[10:19:39.139] Timer tick, asking Buildbucket for the build status
[10:19:39.355] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:39.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:24:0) after 1m0s
[10:20:39.393] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:24:0)
[10:20:39.393] Timer tick, asking Buildbucket for the build status
[10:20:39.462] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:39.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:25:0) after 1m0s
[10:21:39.583] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:25:0)
[10:21:39.583] Timer tick, asking Buildbucket for the build status
[10:21:39.656] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:39.656] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:26:0) after 1m0s
[10:22:39.663] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:26:0)
[10:22:39.663] Timer tick, asking Buildbucket for the build status
[10:22:40.240] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:40.240] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:27:0) after 1m0s
[10:23:40.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:27:0)
[10:23:40.296] Timer tick, asking Buildbucket for the build status
[10:23:40.403] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:40.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:28:0) after 1m0s
[10:24:40.428] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:28:0)
[10:24:40.429] Timer tick, asking Buildbucket for the build status
[10:24:40.523] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:40.523] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:29:0) after 1m0s
[10:25:40.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:29:0)
[10:25:40.538] Timer tick, asking Buildbucket for the build status
[10:25:40.638] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:40.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:30:0) after 1m0s
[10:26:40.692] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:30:0)
[10:26:40.692] Timer tick, asking Buildbucket for the build status
[10:26:40.760] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:40.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:31:0) after 1m0s
[10:27:40.784] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:31:0)
[10:27:40.784] Timer tick, asking Buildbucket for the build status
[10:27:40.843] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:40.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:32:0) after 1m0s
[10:28:40.847] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:32:0)
[10:28:40.847] Timer tick, asking Buildbucket for the build status
[10:28:40.941] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:40.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:33:0) after 1m0s
[10:29:40.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:33:0)
[10:29:40.968] Timer tick, asking Buildbucket for the build status
[10:29:41.039] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:41.039] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:34:0) after 1m0s
[10:30:41.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:34:0)
[10:30:41.085] Timer tick, asking Buildbucket for the build status
[10:30:41.140] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:41.140] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:35:0) after 1m0s
[10:31:41.179] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:35:0)
[10:31:41.179] Timer tick, asking Buildbucket for the build status
[10:31:41.706] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:41.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:36:0) after 1m0s
[10:32:41.834] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:36:0)
[10:32:41.834] Timer tick, asking Buildbucket for the build status
[10:32:41.911] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:41.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:37:0) after 1m0s
[10:33:41.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:37:0)
[10:33:41.951] Timer tick, asking Buildbucket for the build status
[10:33:42.043] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:42.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:38:0) after 1m0s
[10:34:42.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:38:0)
[10:34:42.073] Timer tick, asking Buildbucket for the build status
[10:34:42.141] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:42.141] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:39:0) after 1m0s
[10:35:42.164] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:39:0)
[10:35:42.164] Timer tick, asking Buildbucket for the build status
[10:35:42.227] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:42.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:40:0) after 1m0s
[10:36:42.235] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:40:0)
[10:36:42.235] Timer tick, asking Buildbucket for the build status
[10:36:42.334] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:42.334] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:41:0) after 1m0s
[10:37:42.373] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:41:0)
[10:37:42.373] Timer tick, asking Buildbucket for the build status
[10:37:42.470] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:42.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:42:0) after 1m0s
[10:38:42.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:42:0)
[10:38:42.538] Timer tick, asking Buildbucket for the build status
[10:38:42.718] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:42.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:43:0) after 1m0s
[10:39:42.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:43:0)
[10:39:42.782] Timer tick, asking Buildbucket for the build status
[10:39:42.977] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:42.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:44:0) after 1m0s
[10:40:43.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:44:0)
[10:40:43.072] Timer tick, asking Buildbucket for the build status
[10:40:43.138] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:43.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:45:0) after 1m0s
[10:41:43.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:45:0)
[10:41:43.169] Timer tick, asking Buildbucket for the build status
[10:41:43.316] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:43.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:46:0) after 1m0s
[10:42:43.305] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:46:0)
[10:42:43.305] Timer tick, asking Buildbucket for the build status
[10:42:43.371] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:43.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:47:0) after 1m0s
[10:43:43.398] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:47:0)
[10:43:43.398] Timer tick, asking Buildbucket for the build status
[10:43:43.505] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:43.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:48:0) after 1m0s
[10:44:43.572] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:48:0)
[10:44:43.572] Timer tick, asking Buildbucket for the build status
[10:44:43.883] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:43.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:49:0) after 1m0s
[10:45:43.907] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:49:0)
[10:45:43.907] Timer tick, asking Buildbucket for the build status
[10:45:44.029] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:44.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:50:0) after 1m0s
[10:46:44.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:50:0)
[10:46:44.053] Timer tick, asking Buildbucket for the build status
[10:46:44.233] Build 8867016509566234016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:44.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032446571879336720:51:0) after 1m0s
[10:47:12.342] Received PubSub notification, asking Buildbucket for the build status
[10:47:12.409] Build 8867016509566234016: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:47:12.409] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602154031742473",
"created_by": "project:chromium",
"created_ts": "1602151113884266",
"id": "8867016509566234016",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e835ae293245dffd912a0a95423e6187c16bb9f0\"}}",
"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\": \"e835ae293245dffd912a0a95423e6187c16bb9f0\", \"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-57-guco\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 176455, \"got_angle_revision\": \"1a87f1f025efdbddbc1fca3350b6cc27b2c0bf0d\", \"got_dawn_revision\": \"6b4a4a85dfd778964c48f5cec939b7da160a5db1\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"e835ae293245dffd912a0a95423e6187c16bb9f0\", \"got_revision_cp\": \"refs/heads/master@{#815085}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"5f4e70b81046551e713fdc1d461f9697dc8f8132\", \"got_v8_revision\": \"c942e1b735dcc8bdf3475266418a8ba5288038ac\", \"got_v8_revision_cp\": \"refs/heads/8.8.47@{#1}\", \"got_webrtc_revision\": \"eacbd972ab7e85e9d61851ced57aba1eb194de3d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32316}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e835ae293245dffd912a0a95423e6187c16bb9f0\", \"swarm_hashes_refs/heads/master(at){#815085}_without_patch\": {\"absl_hardening_tests\": \"916f2299a127f796e6e49c71efcdb19a4cb5d296\", \"accessibility_unittests\": \"3330e3adb92b62d5fc4d7ba744330d9c2727f0f7\", \"app_shell_unittests\": \"11f857d1db39906f68ff9b4b2ba6af482defb338\", \"aura_unittests\": \"60326387412b5d388f1c940e5dd9eb9bfe587686\", \"base_unittests\": \"29e1a5861794d8326dd34f34043785285e4ebb16\", \"base_util_unittests\": \"f06b91a02548a6491968a7e18363f1f0544670ee\", \"blink_common_unittests\": \"6f3bca6af76037e6dc9dbb0c64b0579dd49f86cc\", \"blink_fuzzer_unittests\": \"997d26644db329cee5d84800caa6e10d16e3330b\", \"blink_heap_unittests\": \"9639ab37f7f1f1377e8e330f8a0159a26c1beda8\", \"blink_platform_unittests\": \"d14b45d5b299435afd949af85d7838660417bf46\", \"blink_python_tests\": \"0225730cb8414ffe8db7312ff27b71b69e650e60\", \"blink_unittests\": \"38cb266c8536382ba9d7fa7b62ec33ee2171e7c8\", \"blink_web_tests\": \"34978708824e1e1973c7f279547dbf62f1a5a845\", \"boringssl_crypto_tests\": \"6c4793dce0b36639ea136fe219411ef3f1675e39\", \"boringssl_ssl_tests\": \"ae0e195bc6d56baea1ef9e187385679876d032e2\", \"browser_tests\": \"6696a6785c83a7d9f11026377fd4b3198b49d65d\", \"capture_unittests\": \"e8cac48d411ab667ca4cc3ac5665830cdfba8443\", \"cast_unittests\": \"3c0dbb95bfba5c4eabca9232d8d4927ae9777980\", \"cc_unittests\": \"944e68c2ddc115fc32f02d6fb142137e78f11f30\", \"chrome_app_unittests\": \"35221b9c149fb28eab451369549cf6d7c38f846f\", \"chromedriver_unittests\": \"4e2e89669eee445515eb78cfdd774c783d0623c7\", \"components_browsertests\": \"412452950b5099e40949db38af16ba1c2e206710\", \"components_unittests\": \"e8e3b282e5011cdb3e4a3b9c56bce48102c33dee\", \"compositor_unittests\": \"bad58db51f60a19a06b666015cc6343f534d05a2\", \"content_browsertests\": \"6744617a838981d8d5f5454ce3e03f20543e810d\", \"content_shell_crash_test\": \"ee1d2364942c873cd6ed5ba038e029fecce3e0d3\", \"content_unittests\": \"6eb16fcaf4ee923f6c97c330e50d86f564745b97\", \"crashpad_tests\": \"f04714e61547c7558dc371e81e4212d56d59ba8b\", \"cronet_tests\": \"3a830b38b807cc2eca99fff15c9f43108a01cc5f\", \"cronet_unittests\": \"eb2e164cf64f6cea9acbc0eaffbf4fc1def08c1f\", \"crypto_unittests\": \"52df54515c4373540708f642e771a6757c8cd63d\", \"dbus_unittests\": \"6f09e823db6a5d3c769fba39b8a17a40283dd3f7\", \"device_unittests\": \"d49ea4bb0efc5fd1eb84a650e89eed445db944ed\", \"display_unittests\": \"b6215651e110a5ed76b2f5a6d6f1f4840d9f3263\", \"events_unittests\": \"6a68973cefaecc71c7fe04b2e12b35efa2e8b6e7\", \"extension_docserver_python_unittests\": \"26c1268df2512814cc4a97b82ff2137f35c06885\", \"extensions_browsertests\": \"d9c496c59dac1574a8c9f7f3a796d8bf2c15e311\", \"extensions_unittests\": \"1471325446bac4b89c73239a9e786a50e79a9bb0\", \"filesystem_service_unittests\": \"a66765dc2b2b255053038c6449b23727551a342c\", \"flatbuffers_unittests\": \"7c821f13730963d6e07deae074f4fffab315d766\", \"gcm_unit_tests\": \"151cc334d1107e125b318f345c656235b96ed9e0\", \"gfx_unittests\": \"a4bc1c6f5c550e8cd6017b6dd98d86474d241735\", \"gin_unittests\": \"8d884dc51d3b3ec52f58dd4da5b24d8818dac3be\", \"google_apis_unittests\": \"bde837b11d7ab7f2daf71e8275c566a5a039cd81\", \"gpu_unittests\": \"7b72ccbf574aa809abfd0d8479ced3041a3b4e8e\", \"grit_python_unittests\": \"ffc502b47dd9f2295f9c36928d7239431dd05718\", \"gwp_asan_unittests\": \"96029b15838648179ce991dd978dbdf14141f43e\", \"headless_browsertests\": \"9e08ac39e844e8ef86d047701d599fa5adbfc575\", \"headless_unittests\": \"e1f9c3b525bc11a8ff1fa31db1131c15514a4dc1\", \"interactive_ui_tests\": \"f645337be6a5f777ca2c5d515ed21de6417285a4\", \"ipc_tests\": \"e5106a6e7da662a35261cc2b436014e6b863ef53\", \"jingle_unittests\": \"87928a7e4c9c0b95c3681a3bc843ac0388eb63d1\", \"latency_unittests\": \"52fb41d3e91834015209fc8b25720dcc364c337e\", \"libjingle_xmpp_unittests\": \"ea9845d32bab0d76a70303d8f395b172c7c9ee40\", \"media_blink_unittests\": \"e9b5a26fbc19123c3deb309943296d6e2e05e2e9\", \"media_unittests\": \"f509f9ca15c6033667d59307ee2b50b559a255fb\", \"message_center_unittests\": \"3c263ff38743a491f9d6f133ce81047f761f77d3\", \"metrics_python_tests\": \"48bd45cf9b6f36ed7a872c1afc3188fa7a653bc9\", \"midi_unittests\": \"a14b1ca81bc9cf45ccb6d0c04f2a285877721b04\", \"mojo_core_unittests\": \"82eb514aebcc70e7f1b7ccf9d6c1930698ca528d\", \"mojo_unittests\": \"f1725a51e5aa44e15087084b65924cf06d484392\", \"nacl_helper_nonsfi_unittests\": \"a8a37d195a353c26ffa9f413a907dda4c1367569\", \"nacl_loader_unittests\": \"a798d8cdf7dba0e272ae82a648f9e6109a9ed49f\", \"native_theme_unittests\": \"4e26b4b33fb2dd85da006ca5de4321de7036942a\", \"net_unittests\": \"c143580f997f1d1639f2bbb4a39a201a141c8c11\", \"openscreen_unittests\": \"e9ad48bf89028884b3dab5ba113d599829347062\", \"pdf_unittests\": \"97216e44375a73be9c6cd6520f8c36b215b5a7ae\", \"perfetto_unittests\": \"21122625ccb7150a3726e174312157f19f498175\", \"ppapi_unittests\": \"b80dff927f606ea223dbc33d74e7f58747c947d7\", \"printing_unittests\": \"d3a6090a241cf01e05f882eb1abbb1a4a0babe3f\", \"remoting_unittests\": \"a278fdb41add60d366fc1bdf96cd748bac83351d\", \"sandbox_linux_unittests\": \"875989c64ac80ce14c5061d119cc2054605d3bf9\", \"service_manager_unittests\": \"5685f32d56f17345009490fefee138be8bc66ea2\", \"services_unittests\": \"f471059f27cbe50a7fb58f53ca500c12e3e8f140\", \"shell_dialogs_unittests\": \"0e1f0e5937bf6fe497517e833e7f7849a6406f68\", \"skia_unittests\": \"55be0d3750914994eacde7122c8138e246af722f\", \"snapshot_unittests\": \"d19d37d2870b75a022708d6faf4ca59f657f8d53\", \"sql_unittests\": \"5a0b93877e59f613978ba5459172bdb1d97f4f2c\", \"standalone_angle_unittests\": \"f285a5522267422a3decd7170d6d5564a08321fb\", \"storage_unittests\": \"c4fc8fa8d6eec78cc5d430015892cc4467b576c0\", \"sync_integration_tests\": \"4bd8563b88e08d0dd22a156a4be9bcd0d81c1042\", \"telemetry_gpu_unittests\": \"e24cd29a80cdc133c9a675fd4186c7a59708c7e8\", \"telemetry_perf_unittests\": \"04d0b87cd3cd4e583765006a44eb9bcf02b4ea28\", \"telemetry_unittests\": \"fa38d11a0822954ab9ea1ba88216d72a9fe4ee27\", \"traffic_annotation_auditor_unittests\": \"dcf6e9964652705534e8ac041a7c0142e5e3bc4f\", \"ui_base_unittests\": \"00732514761eb4098f4765e2f245e1f5741812a6\", \"ui_touch_selection_unittests\": \"e01d37ec9da471e992a8bf176b4adea7b1782fb4\", \"unit_tests\": \"842744982521eea02bf94fe23614fa2a31558b4e\", \"url_unittests\": \"49e894e679db6bf7874d7f7e22eb46d6d7d4f331\", \"views_perftests\": \"973723850e8af2d6b707d53a46cca66ccceb73b4\", \"views_unittests\": \"4514e49257e62a2ea9d60b6686ca076b9d2446fc\", \"viz_unittests\": \"d08b68eeca6c5ccbe8d081e1620910f86543aadd\", \"vr_common_unittests\": \"ca3e0abda8a88ff82cedf3fe86eec06e41b424da\", \"vr_pixeltests\": \"2d78107e18cd3f70b166bde6eac01641085782a2\", \"webdriver_wpt_tests\": \"dd7135f54aaa63f345890e7698315f99544aa08f\", \"weblayer_browsertests\": \"5ae34437e9c235579db3687c28e5296eef5e0f8e\", \"weblayer_unittests\": \"3485c9beabfb8a9e293e5da32e7adf9dad9d9854\", \"wm_unittests\": \"911e5116ee022f702740c0109c199571b4fe6455\", \"wtf_unittests\": \"c9f2f93c4c67e84a1b345ca65b80c63a82e6018d\", \"x11_unittests\": \"093572829aa3108bc0dbbc10cb527bd09ff871b0\", \"xr_browser_tests\": \"832a40ffad06f06e21902d4074bc903ae963b066\", \"zlib_unittests\": \"107a6876e957f83b865583c955a1a8d471ebc80c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_151f80801b9f29276c11c5f05dab27ce5673f9c9ba442aaf2cf20aab9215f522_v2\", \"builder_32ded518776cda8cac391977d607693e2958c39df4b87a6f7ec8056ca6add5b1_v2\", \"builder_5c906bad1aaeae24a2a7f043536626a3e8df9b2c7401ab4a0dd83c120911bddd_v2\", \"builder_61626c7085ee1f9730db9e25e8ceef3d7b395de70268d432aed853b8a16eb295_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_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-57-guco\"], \"image\": [\"chrome-xenial-20100400-30cd36dae64\"], \"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\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602151357211632",
"status": "COMPLETED",
"status_changed_ts": "1602154032060026",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176455",
"builder:Linux Builder (dbg)",
"buildset:commit/git/e835ae293245dffd912a0a95423e6187c16bb9f0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e835ae293245dffd912a0a95423e6187c16bb9f0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032446571879336720",
"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/8867016509566234016/+/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:4f20776ebabdf610",
"user_agent:luci-scheduler"
],
"updated_ts": "1602154032064853",
"url": "https://ci.chromium.org/b/8867016509566234016",
"utcnow_ts": "1602154032401240"
}
}
[10:47:12.409] Invocation finished in 48m40.115820147s with status SUCCEEDED