[23:48:04.530] New invocation is queued and will start shortly
[23:48:05.612] Starting the invocation (attempt 1)
[23:48:05.644] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:48:05.645] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:48:05.645] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019620209660801248",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"29ea6d9278a84999de48493118d0458858da951e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9019620209660801248",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/29ea6d9278a84999de48493118d0458858da951e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29ea6d9278a84999de48493118d0458858da951e",
"gitiles_ref:refs/heads/master"
]
}
[23:48:06.286] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614383285739971",
"id": "8854190147731643776",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"29ea6d9278a84999de48493118d0458858da951e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614383286182723",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180971",
"builder:Linux Builder (dbg)",
"buildset:commit/git/29ea6d9278a84999de48493118d0458858da951e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29ea6d9278a84999de48493118d0458858da951e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019620209660801248",
"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/8854190147731643776/+/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": "1614383286182914",
"url": "https://ci.chromium.org/b/8854190147731643776",
"utcnow_ts": "1614383286279507"
}
}
[23:48:06.286] Task URL: https://ci.chromium.org/b/8854190147731643776
[23:48:06.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:2:0) after 1m0s
[23:48:09.354] Received PubSub notification, asking Buildbucket for the build status
[23:48:09.416] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:06.274] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:2:0)
[23:49:06.274] Timer tick, asking Buildbucket for the build status
[23:49:06.340] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:06.340] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:4:0) after 1m0s
[23:50:06.417] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:4:0)
[23:50:06.417] Timer tick, asking Buildbucket for the build status
[23:50:06.475] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:06.475] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:5:0) after 1m0s
[23:51:06.461] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:5:0)
[23:51:06.461] Timer tick, asking Buildbucket for the build status
[23:51:06.529] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:06.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:6:0) after 1m0s
[23:52:06.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:6:0)
[23:52:06.630] Timer tick, asking Buildbucket for the build status
[23:52:06.715] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:06.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:7:0) after 1m0s
[23:53:06.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:7:0)
[23:53:06.766] Timer tick, asking Buildbucket for the build status
[23:53:06.868] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:06.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:8:0) after 1m0s
[23:54:06.995] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:8:0)
[23:54:06.995] Timer tick, asking Buildbucket for the build status
[23:54:07.080] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:07.080] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:9:0) after 1m0s
[23:55:07.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:9:0)
[23:55:07.136] Timer tick, asking Buildbucket for the build status
[23:55:07.450] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:07.450] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:10:0) after 1m0s
[23:56:07.534] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:10:0)
[23:56:07.534] Timer tick, asking Buildbucket for the build status
[23:56:07.617] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:07.617] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:11:0) after 1m0s
[23:57:07.633] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:11:0)
[23:57:07.633] Timer tick, asking Buildbucket for the build status
[23:57:07.703] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:07.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:12:0) after 1m0s
[23:58:07.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:12:0)
[23:58:07.743] Timer tick, asking Buildbucket for the build status
[23:58:07.840] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:07.840] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:13:0) after 1m0s
[23:59:07.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:13:0)
[23:59:07.857] Timer tick, asking Buildbucket for the build status
[23:59:07.934] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:07.934] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:14:0) after 1m0s
[00:00:08.013] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:14:0)
[00:00:08.013] Timer tick, asking Buildbucket for the build status
[00:00:08.094] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:08.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:15:0) after 1m0s
[00:01:08.130] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:15:0)
[00:01:08.130] Timer tick, asking Buildbucket for the build status
[00:01:08.415] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:08.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:16:0) after 1m0s
[00:02:08.488] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:16:0)
[00:02:08.488] Timer tick, asking Buildbucket for the build status
[00:02:08.571] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:08.571] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:17:0) after 1m0s
[00:03:08.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:17:0)
[00:03:08.593] Timer tick, asking Buildbucket for the build status
[00:03:08.683] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:08.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:18:0) after 1m0s
[00:04:08.776] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:18:0)
[00:04:08.776] Timer tick, asking Buildbucket for the build status
[00:04:08.858] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:08.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:19:0) after 1m0s
[00:05:08.873] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:19:0)
[00:05:08.873] Timer tick, asking Buildbucket for the build status
[00:05:08.937] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:08.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:20:0) after 1m0s
[00:06:09.013] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:20:0)
[00:06:09.013] Timer tick, asking Buildbucket for the build status
[00:06:09.079] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:09.079] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:21:0) after 1m0s
[00:07:09.110] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:21:0)
[00:07:09.110] Timer tick, asking Buildbucket for the build status
[00:07:09.292] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:09.292] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:22:0) after 1m0s
[00:08:09.364] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:22:0)
[00:08:09.364] Timer tick, asking Buildbucket for the build status
[00:08:09.706] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:09.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:23:0) after 1m0s
[00:09:09.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:23:0)
[00:09:09.749] Timer tick, asking Buildbucket for the build status
[00:09:09.823] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:09.823] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:24:0) after 1m0s
[00:10:09.902] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:24:0)
[00:10:09.902] Timer tick, asking Buildbucket for the build status
[00:10:10.498] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:10.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:25:0) after 1m0s
[00:11:10.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:25:0)
[00:11:10.522] Timer tick, asking Buildbucket for the build status
[00:11:10.702] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:10.702] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:26:0) after 1m0s
[00:12:10.715] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:26:0)
[00:12:10.715] Timer tick, asking Buildbucket for the build status
[00:12:10.867] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:10.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:27:0) after 1m0s
[00:13:10.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:27:0)
[00:13:10.876] Timer tick, asking Buildbucket for the build status
[00:13:11.126] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:11.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:28:0) after 1m0s
[00:14:11.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:28:0)
[00:14:11.127] Timer tick, asking Buildbucket for the build status
[00:14:11.294] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:11.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:29:0) after 1m0s
[00:15:11.308] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:29:0)
[00:15:11.308] Timer tick, asking Buildbucket for the build status
[00:15:11.388] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:11.388] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:30:0) after 1m0s
[00:16:11.405] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:30:0)
[00:16:11.405] Timer tick, asking Buildbucket for the build status
[00:16:11.482] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:11.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:31:0) after 1m0s
[00:17:11.527] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:31:0)
[00:17:11.527] Timer tick, asking Buildbucket for the build status
[00:17:11.706] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:11.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:32:0) after 1m0s
[00:18:11.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:32:0)
[00:18:11.727] Timer tick, asking Buildbucket for the build status
[00:18:12.028] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:12.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:33:0) after 1m0s
[00:19:12.094] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:33:0)
[00:19:12.094] Timer tick, asking Buildbucket for the build status
[00:19:12.287] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:12.287] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:34:0) after 1m0s
[00:20:12.260] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:34:0)
[00:20:12.260] Timer tick, asking Buildbucket for the build status
[00:20:12.330] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:12.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:35:0) after 1m0s
[00:21:12.351] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:35:0)
[00:21:12.351] Timer tick, asking Buildbucket for the build status
[00:21:12.428] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:12.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:36:0) after 1m0s
[00:22:12.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:36:0)
[00:22:12.516] Timer tick, asking Buildbucket for the build status
[00:22:12.862] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:12.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:37:0) after 1m0s
[00:23:12.878] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:37:0)
[00:23:12.878] Timer tick, asking Buildbucket for the build status
[00:23:13.049] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:13.049] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:38:0) after 1m0s
[00:24:13.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:38:0)
[00:24:13.077] Timer tick, asking Buildbucket for the build status
[00:24:13.157] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:13.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:39:0) after 1m0s
[00:25:13.197] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:39:0)
[00:25:13.197] Timer tick, asking Buildbucket for the build status
[00:25:13.276] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:13.276] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:40:0) after 1m0s
[00:26:13.322] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:40:0)
[00:26:13.322] Timer tick, asking Buildbucket for the build status
[00:26:13.526] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:13.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:41:0) after 1m0s
[00:27:13.585] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:41:0)
[00:27:13.585] Timer tick, asking Buildbucket for the build status
[00:27:13.736] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:13.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:42:0) after 1m0s
[00:28:13.757] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:42:0)
[00:28:13.757] Timer tick, asking Buildbucket for the build status
[00:28:13.863] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:13.863] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:43:0) after 1m0s
[00:29:13.881] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:43:0)
[00:29:13.881] Timer tick, asking Buildbucket for the build status
[00:29:14.364] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:14.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:44:0) after 1m0s
[00:30:14.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:44:0)
[00:30:14.395] Timer tick, asking Buildbucket for the build status
[00:30:14.468] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:14.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:45:0) after 1m0s
[00:31:14.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:45:0)
[00:31:14.483] Timer tick, asking Buildbucket for the build status
[00:31:14.889] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:14.889] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:46:0) after 1m0s
[00:32:14.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:46:0)
[00:32:14.937] Timer tick, asking Buildbucket for the build status
[00:32:15.186] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:15.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:47:0) after 1m0s
[00:33:15.220] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:47:0)
[00:33:15.220] Timer tick, asking Buildbucket for the build status
[00:33:15.592] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:15.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:48:0) after 1m0s
[00:34:15.638] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:48:0)
[00:34:15.638] Timer tick, asking Buildbucket for the build status
[00:34:15.729] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:15.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:49:0) after 1m0s
[00:35:15.773] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:49:0)
[00:35:15.773] Timer tick, asking Buildbucket for the build status
[00:35:16.155] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:16.155] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:50:0) after 1m0s
[00:36:16.210] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:50:0)
[00:36:16.210] Timer tick, asking Buildbucket for the build status
[00:36:16.426] Build 8854190147731643776: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:16.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9019620209660801248:51:0) after 1m0s
[00:36:44.537] Received PubSub notification, asking Buildbucket for the build status
[00:36:44.613] Build 8854190147731643776: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:36:44.613] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614386203487933",
"created_by": "project:chromium",
"created_ts": "1614383285739971",
"id": "8854190147731643776",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"29ea6d9278a84999de48493118d0458858da951e\"}}",
"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\": \"29ea6d9278a84999de48493118d0458858da951e\", \"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-77-lyi8\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180971, \"got_angle_revision\": \"33907625dbcaab89bb7f62abea53f40eb9488754\", \"got_dawn_revision\": \"329c1c98fef964ea532a0579ae6f2553ff3382c5\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"29ea6d9278a84999de48493118d0458858da951e\", \"got_revision_cp\": \"refs/heads/master@{#858339}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"45e415150419491d6d12428ba6ee98876a405ba4\", \"got_v8_revision_cp\": \"refs/heads/9.1.1@{#1}\", \"got_webrtc_revision\": \"376cf384ac689eca0bf8d4d1d3a3cf80888d3fbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33348}\", \"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\": \"29ea6d9278a84999de48493118d0458858da951e\", \"swarm_hashes_refs/heads/master(at){#858339}_without_patch\": {\"absl_hardening_tests\": \"8a55701d1f751e21a359295715cd17dde23d29d6\", \"accessibility_unittests\": \"124ac84225ebd470b1874291cb9c47ebddc64a57\", \"angle_unittests\": \"7b16a3076257f65678785be4b7ba358e9286d0b8\", \"app_shell_unittests\": \"3250c0c24c0e262b5ac1b43c5c3d383aec20a9a0\", \"aura_unittests\": \"c6d4c4c06bc1743afe978900b466977da6b3f039\", \"base_unittests\": \"d885e22ffed123197aa18b5826de73b26624f733\", \"base_util_unittests\": \"e2c993eb676d370a18eb5d4225609c56c0cccb4b\", \"blink_common_unittests\": \"09793e22c578da78179997fbdfa0a92e2e0912f0\", \"blink_fuzzer_unittests\": \"eb186030f1f9c0f05be8e3eb781355b825e5a6dd\", \"blink_heap_unittests\": \"457c46152b2b7f5f128bd5c7d805d630c41855bc\", \"blink_platform_unittests\": \"d3781abc38bc7169089659965160ff6bc44ceb20\", \"blink_python_tests\": \"c76b2c1d165598ce97575d37cd353ea1473aaf9c\", \"blink_unittests\": \"9522b07ccdae44ad325cfc3758a0073bd23c8bec\", \"blink_web_tests\": \"0f038c795d4561806a2bd304ff35a7e48ed66b13\", \"boringssl_crypto_tests\": \"d68f49b04485ca2c7d6c705266b78c36e46ff915\", \"boringssl_ssl_tests\": \"5fc6482a225e0085d9e680ad2bc94cb0ad81a4b9\", \"browser_tests\": \"2c8080480d6b596d530b91a0034a499ae1e38ffe\", \"capture_unittests\": \"1ac5ec9aaf0c40cc09ad00020fede7231d8a68dc\", \"cast_unittests\": \"39a27a9c67b0bd62d4f92d495455bbaff850d708\", \"cc_unittests\": \"6340184ea95d3735e1bdb1e7ad26e06fd9e718c4\", \"chrome_app_unittests\": \"ad8b7980875785134affa08a2bc0ac00f2f4b554\", \"chromedriver_unittests\": \"7f05468b20e25f6fe165aec9fa6a6b794aab9c6f\", \"color_unittests\": \"a12995568da72d8f764f90983e612415b08c51dc\", \"components_browsertests\": \"f2801146bf57bdc28d0b92c829271c5a98d3301a\", \"components_unittests\": \"5d3f6203d429750bb1ed2c34d781f846bd006bb4\", \"compositor_unittests\": \"d80c9d95bfd8ece62a1e91c933acda0a9fe53ea8\", \"content_browsertests\": \"5ba9b3b36dc5b41d41d9f0cbcea7cbff3adb67c2\", \"content_shell_crash_test\": \"0bb30698cb5588058af71132ec3820cc0328176f\", \"content_unittests\": \"ed69451b326e0923a0444e6c37b7f45b7a621de5\", \"crashpad_tests\": \"d6b5fd4d98967fbff018849b087998a7f0000bef\", \"cronet_tests\": \"e9a3666fecd072e8bb31c5dd8587394f01445c4d\", \"cronet_unittests\": \"8b1bb27754791c5220190dce31d8fbb02f19836a\", \"crypto_unittests\": \"dc5a608ab7ba0fe5b0a7765fc3fbd0dbeb5e73d5\", \"dbus_unittests\": \"0f2c20f08a7bcd672028673cff08c94bb34c6665\", \"device_unittests\": \"09e0eee8a738d7eeff8677425a4de85a9834cd22\", \"display_unittests\": \"d34f42ca3547072cc0b0f6e1b8d97079353f831f\", \"events_unittests\": \"40cb39ca16e8492ac97d6b50361bc76739914ce6\", \"extensions_browsertests\": \"66f504e335fe9b26151ac52c47fc233a3bfb9dcd\", \"extensions_unittests\": \"4d37b2e5232f24da5705520b38cf56398b283403\", \"filesystem_service_unittests\": \"0da6f7657bbcad13516dd786c45886ae3b59ee76\", \"flatbuffers_unittests\": \"b321573a6e379376cdf327a0c56c65611af14695\", \"gcm_unit_tests\": \"568a0089b1d030ef7771627056784c65e055fe72\", \"gfx_unittests\": \"436a377e31f803185392389999d770fe754ae4ef\", \"gin_unittests\": \"49a0674740406aa4ff7e3d4b42f16c38e223f6d8\", \"google_apis_unittests\": \"dd9267c7e8f354dafa69d59eae50078662a40744\", \"gpu_unittests\": \"b4a6cb538d80e40474aaafa97b14dc0397542490\", \"grit_python_unittests\": \"00738482c42a9310ca0fd96f0709b3d808390403\", \"gwp_asan_unittests\": \"92189fbcbb4e1dbe5151e1abb9bb19edf6cd390d\", \"headless_browsertests\": \"890c34f8e6e383bde003a9badc906b48f37b0c7d\", \"headless_unittests\": \"799a4be2c6e21850bf0c5acbe77b88750e3767cc\", \"interactive_ui_tests\": \"b95f3f2696d537218cb6b56c3ae8105e254d5ee3\", \"ipc_tests\": \"bcd8fd9c07f1e75bc6523d1299d0c4ac6bd1e330\", \"jingle_unittests\": \"fb131d2b348bda81489711d8061bf47baa766f2e\", \"latency_unittests\": \"192202e02b5034e3a7e39fc360eca47d4105dc55\", \"libjingle_xmpp_unittests\": \"ad49daba9549a58b915a2f2c550bb15e1790320d\", \"liburlpattern_unittests\": \"9cf7141d03848bd60ecf44d349b1b27a7a7bcf7f\", \"media_blink_unittests\": \"26d2a29943b6855766efd69f4c5d34661e08956a\", \"media_unittests\": \"3557c88c0f6672303efeb57256828504f6e3ea29\", \"message_center_unittests\": \"f0516a67d432d48c475d47006f67fbb2c4c8d6e4\", \"metrics_python_tests\": \"56f18bb8ec344fddeef1711a66f532c3a7badc0c\", \"midi_unittests\": \"2e945b250e34b6bc28f4b9d04b15685e03b50088\", \"mojo_core_unittests\": \"544ac9b3e9346c54e015bab61b91eddee94df347\", \"mojo_unittests\": \"a59e9196a62d8a051e170a99507f2df2fb237260\", \"nacl_helper_nonsfi_unittests\": \"951d902c865d70585a439825f2254fc68c3638a6\", \"nacl_loader_unittests\": \"6dd99314d6d3c77fcbba133d37c56bfda509b3d1\", \"native_theme_unittests\": \"0dcfa9deb8e944c1c11941b50ff83be29a77c18b\", \"net_unittests\": \"ea94f56e6a755fbf2c6cb4a0a00794ed0fa47a07\", \"openscreen_unittests\": \"c0c700ad76953c16b880276838cb503d4554cad9\", \"pdf_unittests\": \"cf60a981edc7c490297b8bfc9348ac256871ff4a\", \"perfetto_unittests\": \"eeb30e937fc90f141f083ae2b14d297e69189236\", \"ppapi_unittests\": \"878071c35940ea9aec67a4f2ec27486244df3f5c\", \"printing_unittests\": \"05d2cd35305d25abb276005305055d5b1712748e\", \"remoting_unittests\": \"071c558179c6e5caa9235f0bba9ec67818f9a6fb\", \"sandbox_linux_unittests\": \"d1fba41fc10ff32fe4623015e09d7f6062402290\", \"service_manager_unittests\": \"65a613c84aafcb8b5c15a7c76e36525f4d342781\", \"services_unittests\": \"d7e0744983a3ff4276bba513a4ae41b5f27af930\", \"shell_dialogs_unittests\": \"33f2a31a5f5020c64a90c95b30205de4319e72ac\", \"skia_unittests\": \"60823f920cc805a01383e16e25b54c027964ddb6\", \"snapshot_unittests\": \"5cf541ee6e7364105dfe18fbf96a9578b6e8a775\", \"sql_unittests\": \"c70a8c3948d0d8c8e18e3b0ea8a9fb55d2e9c7f3\", \"storage_unittests\": \"6bebac1cfe757ed0667904ad237938b255f683be\", \"sync_integration_tests\": \"d2f3df95df0cca781a2f94252f5c45b1ffd12e3b\", \"telemetry_gpu_unittests\": \"c2e214742d40d2c732ab7d5648e1b6a11718c277\", \"telemetry_perf_unittests\": \"74bfab0168e59490d45bbd272dcc509a943a0852\", \"telemetry_unittests\": \"ccacd7524975c7e451a4e4cdae54f7cb137b632a\", \"traffic_annotation_auditor_unittests\": \"ca06d2ba0cbfcf5c8efcabaf8d37ca652516cc26\", \"ui_base_unittests\": \"6bcf179f3ffa5dd1d32bce545fe6ef45fac5d2d9\", \"ui_touch_selection_unittests\": \"fd8349da10dc6e515a32a1d8dfe165532f01ab10\", \"unit_tests\": \"2de8efab4c2bdb80c3be3e17ce2b371502d7c40d\", \"url_unittests\": \"8c5c8b7cf03b4bd87ad5f701291ed6e0006e794e\", \"views_perftests\": \"7215486fa250c8fc1342ccb335e6c9ae3f959adf\", \"views_unittests\": \"c276bde74433d40e6bf63f0e3a39e2c5af753b5c\", \"viz_unittests\": \"bed4705997ba66831c5786da7e64c5da709b2c07\", \"vr_common_unittests\": \"cf83d1b8d44a38845e6d228508ec76fd19ef0ac9\", \"vr_pixeltests\": \"f3cb0861e5aa15162fcd5d9bf55b475f57181435\", \"webdriver_wpt_tests\": \"59036392a11fdca96a9e8c6a9b3f6e4fa348bab5\", \"weblayer_browsertests\": \"de3d1788fd4685ce1a8f61c5f0250dcd1615910a\", \"weblayer_unittests\": \"a7499d3413498d8b9feee44ec84ccc8ccba8992b\", \"wm_unittests\": \"ed98556e0a6d2502dc3f046c4ed6ed5622bcb395\", \"wtf_unittests\": \"7a27e3a6fe3e0e9a25f355efdd06f3fb065942eb\", \"x11_unittests\": \"73dfdcf12312b6c08958e23fb78ac281c1a9a28f\", \"xr_browser_tests\": \"6d22e55e9b0e8b97c120e4b058edcb2d30045b5b\", \"zlib_unittests\": \"c71a07466e7744819e7402d77000791e638ae28c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_151f80801b9f29276c11c5f05dab27ce5673f9c9ba442aaf2cf20aab9215f522_v2\", \"builder_158d0f10fa5d87b7b90de0551ce233e88e46559602c021beec49ce89728c3318_v2\", \"builder_197e8aed8afdb4f2db5daf8954e5f1e8e76b914aa8de2eb6ac17c11267e25f98_v2\", \"builder_554b324272771ff5af13275cc9c865b3499df108d1c4d159c356d5c678bf725c_v2\", \"builder_de67dcb387b95c18ea83e54ea320474d260d319089536d63e3279fdbb975ff72_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-east1-d-8-77-lyi8\"], \"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\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614383288234235",
"status": "COMPLETED",
"status_changed_ts": "1614386204212949",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180971",
"builder:Linux Builder (dbg)",
"buildset:commit/git/29ea6d9278a84999de48493118d0458858da951e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/29ea6d9278a84999de48493118d0458858da951e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019620209660801248",
"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/8854190147731643776/+/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:51f98f90afcbc710",
"user_agent:luci-scheduler"
],
"updated_ts": "1614386204217645",
"url": "https://ci.chromium.org/b/8854190147731643776",
"utcnow_ts": "1614386204604431"
}
}
[00:36:44.613] Invocation finished in 48m40.098145433s with status SUCCEEDED