[20:33:36.474] New invocation is queued and will start shortly
[20:33:37.669] Starting the invocation (attempt 1)
[20:33:37.707] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:33:37.707] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:33:37.708] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018092296076324976",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f816ae0392547a30dcc1beaeb3b904a4d0bae321\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9018092296076324976",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/f816ae0392547a30dcc1beaeb3b904a4d0bae321",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f816ae0392547a30dcc1beaeb3b904a4d0bae321",
"gitiles_ref:refs/heads/master"
]
}
[20:33:38.905] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615840417790387",
"id": "8852662234033667424",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f816ae0392547a30dcc1beaeb3b904a4d0bae321\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615840418557903",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46164",
"builder:linux-chromeos-rel",
"buildset:commit/git/f816ae0392547a30dcc1beaeb3b904a4d0bae321",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f816ae0392547a30dcc1beaeb3b904a4d0bae321",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018092296076324976",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852662234033667424/+/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": "1615840418558034",
"url": "https://ci.chromium.org/b/8852662234033667424",
"utcnow_ts": "1615840418855704"
}
}
[20:33:38.905] Task URL: https://ci.chromium.org/b/8852662234033667424
[20:33:38.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:2:0) after 1m0s
[20:34:39.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:2:0)
[20:34:39.084] Timer tick, asking Buildbucket for the build status
[20:34:39.363] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:39.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:3:0) after 1m0s
[20:35:39.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:3:0)
[20:35:39.430] Timer tick, asking Buildbucket for the build status
[20:35:39.505] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:39.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:4:0) after 1m0s
[20:36:39.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:4:0)
[20:36:39.684] Timer tick, asking Buildbucket for the build status
[20:36:39.901] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:39.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:5:0) after 1m0s
[20:37:40.120] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:5:0)
[20:37:40.120] Timer tick, asking Buildbucket for the build status
[20:37:40.208] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:40.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:6:0) after 1m0s
[20:38:40.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:6:0)
[20:38:40.907] Timer tick, asking Buildbucket for the build status
[20:38:41.022] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:41.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:7:0) after 1m0s
[20:39:37.856] Received PubSub notification, asking Buildbucket for the build status
[20:39:37.951] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:41.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:7:0)
[20:39:41.119] Timer tick, asking Buildbucket for the build status
[20:39:42.375] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:42.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:9:0) after 1m0s
[20:40:42.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:9:0)
[20:40:42.395] Timer tick, asking Buildbucket for the build status
[20:40:42.542] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:42.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:10:0) after 1m0s
[20:41:42.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:10:0)
[20:41:42.599] Timer tick, asking Buildbucket for the build status
[20:41:42.732] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:42.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:11:0) after 1m0s
[20:42:42.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:11:0)
[20:42:42.748] Timer tick, asking Buildbucket for the build status
[20:42:42.875] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:42.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:12:0) after 1m0s
[20:43:42.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:12:0)
[20:43:42.892] Timer tick, asking Buildbucket for the build status
[20:43:42.993] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:42.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:13:0) after 1m0s
[20:44:43.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:13:0)
[20:44:43.014] Timer tick, asking Buildbucket for the build status
[20:44:43.098] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:43.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:14:0) after 1m0s
[20:45:43.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:14:0)
[20:45:43.088] Timer tick, asking Buildbucket for the build status
[20:45:43.183] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:43.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:15:0) after 1m0s
[20:46:43.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:15:0)
[20:46:43.220] Timer tick, asking Buildbucket for the build status
[20:46:43.530] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:43.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:16:0) after 1m0s
[20:47:43.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:16:0)
[20:47:43.657] Timer tick, asking Buildbucket for the build status
[20:47:44.631] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:44.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:17:0) after 1m0s
[20:48:44.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:17:0)
[20:48:44.680] Timer tick, asking Buildbucket for the build status
[20:48:44.832] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:44.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:18:0) after 1m0s
[20:49:44.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:18:0)
[20:49:44.832] Timer tick, asking Buildbucket for the build status
[20:49:44.927] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:44.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:19:0) after 1m0s
[20:50:44.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:19:0)
[20:50:44.998] Timer tick, asking Buildbucket for the build status
[20:50:45.105] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:45.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:20:0) after 1m0s
[20:51:45.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:20:0)
[20:51:45.620] Timer tick, asking Buildbucket for the build status
[20:51:46.310] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:46.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:21:0) after 1m0s
[20:52:46.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:21:0)
[20:52:46.372] Timer tick, asking Buildbucket for the build status
[20:52:46.640] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:46.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:22:0) after 1m0s
[20:53:46.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:22:0)
[20:53:46.734] Timer tick, asking Buildbucket for the build status
[20:53:47.055] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:47.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:23:0) after 1m0s
[20:54:47.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:23:0)
[20:54:47.134] Timer tick, asking Buildbucket for the build status
[20:54:47.206] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:47.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:24:0) after 1m0s
[20:55:47.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:24:0)
[20:55:47.229] Timer tick, asking Buildbucket for the build status
[20:55:47.623] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:47.623] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:25:0) after 1m0s
[20:56:47.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:25:0)
[20:56:47.622] Timer tick, asking Buildbucket for the build status
[20:56:47.688] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:47.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:26:0) after 1m0s
[20:57:47.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:26:0)
[20:57:47.710] Timer tick, asking Buildbucket for the build status
[20:57:47.840] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:47.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:27:0) after 1m0s
[20:58:47.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:27:0)
[20:58:47.867] Timer tick, asking Buildbucket for the build status
[20:58:47.977] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:47.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:28:0) after 1m0s
[20:59:47.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:28:0)
[20:59:47.994] Timer tick, asking Buildbucket for the build status
[20:59:48.158] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:48.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:29:0) after 1m0s
[21:00:48.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:29:0)
[21:00:48.175] Timer tick, asking Buildbucket for the build status
[21:00:48.518] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:48.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:30:0) after 1m0s
[21:01:49.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:30:0)
[21:01:49.062] Timer tick, asking Buildbucket for the build status
[21:01:49.372] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:49.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:31:0) after 1m0s
[21:02:49.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:31:0)
[21:02:49.576] Timer tick, asking Buildbucket for the build status
[21:02:49.650] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:49.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:32:0) after 1m0s
[21:03:49.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:32:0)
[21:03:49.777] Timer tick, asking Buildbucket for the build status
[21:03:49.927] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:49.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:33:0) after 1m0s
[21:04:51.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:33:0)
[21:04:51.000] Timer tick, asking Buildbucket for the build status
[21:04:51.156] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:51.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:34:0) after 1m0s
[21:05:51.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:34:0)
[21:05:51.313] Timer tick, asking Buildbucket for the build status
[21:05:52.000] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:52.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:35:0) after 1m0s
[21:06:52.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:35:0)
[21:06:52.278] Timer tick, asking Buildbucket for the build status
[21:06:52.389] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:52.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:36:0) after 1m0s
[21:07:52.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:36:0)
[21:07:52.488] Timer tick, asking Buildbucket for the build status
[21:07:52.885] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:52.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:37:0) after 1m0s
[21:08:53.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:37:0)
[21:08:53.498] Timer tick, asking Buildbucket for the build status
[21:08:54.578] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:54.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:38:0) after 1m0s
[21:09:54.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:38:0)
[21:09:54.713] Timer tick, asking Buildbucket for the build status
[21:09:54.798] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:54.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:39:0) after 1m0s
[21:10:54.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:39:0)
[21:10:54.876] Timer tick, asking Buildbucket for the build status
[21:10:54.962] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:54.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:40:0) after 1m0s
[21:11:55.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:40:0)
[21:11:55.069] Timer tick, asking Buildbucket for the build status
[21:11:55.165] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:55.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:41:0) after 1m0s
[21:12:55.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:41:0)
[21:12:55.456] Timer tick, asking Buildbucket for the build status
[21:12:56.420] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:56.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:42:0) after 1m0s
[21:13:56.534] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:42:0)
[21:13:56.534] Timer tick, asking Buildbucket for the build status
[21:13:56.647] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:56.647] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:43:0) after 1m0s
[21:14:56.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:43:0)
[21:14:56.662] Timer tick, asking Buildbucket for the build status
[21:14:56.733] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:56.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:44:0) after 1m0s
[21:15:56.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:44:0)
[21:15:56.796] Timer tick, asking Buildbucket for the build status
[21:15:56.965] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:56.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:45:0) after 1m0s
[21:16:57.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:45:0)
[21:16:57.062] Timer tick, asking Buildbucket for the build status
[21:16:57.129] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:57.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:46:0) after 1m0s
[21:17:57.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:46:0)
[21:17:57.274] Timer tick, asking Buildbucket for the build status
[21:17:57.350] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:57.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:47:0) after 1m0s
[21:18:57.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:47:0)
[21:18:57.497] Timer tick, asking Buildbucket for the build status
[21:18:57.612] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:57.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:48:0) after 1m0s
[21:20:00.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:48:0)
[21:20:00.292] Timer tick, asking Buildbucket for the build status
[21:20:00.381] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:00.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:49:0) after 1m0s
[21:21:00.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:49:0)
[21:21:00.411] Timer tick, asking Buildbucket for the build status
[21:21:00.925] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:00.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:50:0) after 1m0s
[21:22:01.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:50:0)
[21:22:01.222] Timer tick, asking Buildbucket for the build status
[21:22:01.614] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:01.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:51:0) after 1m0s
[21:23:01.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:51:0)
[21:23:01.688] Timer tick, asking Buildbucket for the build status
[21:23:01.816] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:01.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:52:0) after 1m0s
[21:24:02.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:52:0)
[21:24:02.168] Timer tick, asking Buildbucket for the build status
[21:24:02.507] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:02.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:53:0) after 1m0s
[21:25:02.525] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:53:0)
[21:25:02.525] Timer tick, asking Buildbucket for the build status
[21:25:03.240] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:03.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:54:0) after 1m0s
[21:26:03.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:54:0)
[21:26:03.300] Timer tick, asking Buildbucket for the build status
[21:26:03.436] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:03.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:55:0) after 1m0s
[21:27:03.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:55:0)
[21:27:03.440] Timer tick, asking Buildbucket for the build status
[21:27:03.521] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:03.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:56:0) after 1m0s
[21:28:03.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:56:0)
[21:28:03.579] Timer tick, asking Buildbucket for the build status
[21:28:03.760] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:03.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:57:0) after 1m0s
[21:29:03.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:57:0)
[21:29:03.820] Timer tick, asking Buildbucket for the build status
[21:29:04.670] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:04.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:58:0) after 1m0s
[21:30:04.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:58:0)
[21:30:04.730] Timer tick, asking Buildbucket for the build status
[21:30:04.968] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:04.968] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:59:0) after 1m0s
[21:31:04.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:59:0)
[21:31:04.997] Timer tick, asking Buildbucket for the build status
[21:31:05.301] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:05.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:60:0) after 1m0s
[21:32:05.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:60:0)
[21:32:05.358] Timer tick, asking Buildbucket for the build status
[21:32:05.461] Build 8852662234033667424: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:05.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018092296076324976:61:0) after 1m0s
[21:32:15.655] Received PubSub notification, asking Buildbucket for the build status
[21:32:15.760] Build 8852662234033667424: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:32:15.760] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615843934736884",
"created_by": "project:chromium",
"created_ts": "1615840417790387",
"id": "8852662234033667424",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f816ae0392547a30dcc1beaeb3b904a4d0bae321\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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\": \"f816ae0392547a30dcc1beaeb3b904a4d0bae321\", \"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-4-610t\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 46164, \"got_angle_revision\": \"a11d65a172f885042cf4fdab5bfd124d174f5190\", \"got_dawn_revision\": \"8c40cad1c92d7e85154bbae4cb92539e2200d139\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"f816ae0392547a30dcc1beaeb3b904a4d0bae321\", \"got_revision_cp\": \"refs/heads/master@{#862940}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"69b79eec6533f113920a5dd863ee2dea7d0c64e7\", \"got_v8_revision\": \"d7ff8abb545ad8160e189a7e8352c13c7b0e30b8\", \"got_v8_revision_cp\": \"refs/heads/9.1.126@{#1}\", \"got_webrtc_revision\": \"6097b0fac0946a29d59a9266ea656c39b3fd7336\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33456}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f816ae0392547a30dcc1beaeb3b904a4d0bae321\", \"swarm_hashes_refs/heads/master(at){#862940}_without_patch\": {\"absl_hardening_tests\": \"94311884c8cd85cc7da7cc447e8e52b9fa393b60\", \"accessibility_unittests\": \"95e3b182fbb2a6aa5b3d00b2c2e66062096ee336\", \"angle_unittests\": \"2ce1e1ee77c88c22d7fc9bcf16827e77c7d59f43\", \"app_list_unittests\": \"a9390268b36ad73a00b95b7a0e6499ed8fd0a0ae\", \"app_shell_unittests\": \"14c653248284710523f8840deec1ba0fbcd8d21a\", \"ash_unittests\": \"46d9f40d2f1efc6dd7a07193334aa4a6ab9d49d3\", \"aura_unittests\": \"ebce398559a2fe2e047e81906e147087a0803453\", \"base_unittests\": \"de1627fcae50327d5ad0176fd84eec817efdec9f\", \"base_util_unittests\": \"045cbde2d0387771e75f05065b2839d6dbf0aec7\", \"blink_common_unittests\": \"b5aa21ff0f1d478658a284530e88e29600cf3b07\", \"blink_fuzzer_unittests\": \"08e3216effe1496b2e0467fb3da5e74906735980\", \"blink_heap_unittests\": \"f4d800c102ddd2b6b2621e7e431312925ef80e9a\", \"blink_platform_unittests\": \"ff215f18fdb5a9bc2cd4b0505127f904dd3d35e1\", \"blink_unittests\": \"04ae193d610f87c339223a3ab6117d9397902764\", \"boringssl_crypto_tests\": \"8a1e58e1e074c5f3bb7e2b8faf77e5a16af912fb\", \"boringssl_ssl_tests\": \"5d532f6a59bba42ea889c879bbba45ca8e7a843c\", \"browser_tests\": \"ec6eeb0b46c0a326838640603abdd64705d121c7\", \"capture_unittests\": \"1cea38889341eb4b96ee9a7e6a76ccde3705a81c\", \"cast_unittests\": \"530060a03cbea726c48569c3a942d6e8db1200db\", \"cc_unittests\": \"377c4cb6078f8c778cffea1411e49c2840fd79ae\", \"chrome_app_unittests\": \"90998815b4d65dc8539f235f3363753e0de1e77b\", \"chromedriver_unittests\": \"f4ce40fa787370eca8d980f87948336d9ca68cc6\", \"chromeos_components_unittests\": \"2eed3ee2ad92efa6ca7bc8a97a13c12ea5959125\", \"chromeos_unittests\": \"e8705f9a31db8e4b2e26a7f17fea575760d4f7df\", \"color_unittests\": \"41746e86213ff34114cd13e11df690a3ad3bae9e\", \"components_browsertests\": \"90d29edc1f841dd265cc1b24615555d19a1798f1\", \"components_unittests\": \"2b9c5598ab915653abcbc2bd76541efc7e80c012\", \"compositor_unittests\": \"be452cecf4f986b03205f9b56653bbff085dcbae\", \"content_browsertests\": \"51beadbee602ae47ffa461b47bff714c564c6066\", \"content_unittests\": \"37815a88cb7c087d27b27f3f02d598b4f9b71824\", \"crashpad_tests\": \"202b98901b223c1c0a976ae13f2ea5de24efd7dc\", \"crypto_unittests\": \"02147f733cac04ebcb6a1f5ce5b512b9ccea2631\", \"dbus_unittests\": \"8b28e215c160dcfe9285b0b57135877b610cc6fc\", \"device_unittests\": \"a1969f8fea8a1c5525deee6bfe391e78d5015b18\", \"display_unittests\": \"083d0963c890ba45a4bcb99a7e4c3e78260df166\", \"events_unittests\": \"cbfcf4c8d738df9a1c192125608aab8938fcd62e\", \"exo_unittests\": \"676ea49b00b08dac6d6dd886e8e34f9894bab029\", \"extensions_browsertests\": \"7d062a6f1c63d1d82bd2ed4420a4e1afa6e3097e\", \"extensions_unittests\": \"c4ec7a31acb572f0bf0da1f98d82f070197fb53c\", \"filesystem_service_unittests\": \"5f2e4f290329451cdf697070a6c421284c758856\", \"gcm_unit_tests\": \"9ddef9b02282bd8ec7bc7677ebfaa949f09c21d0\", \"gfx_unittests\": \"3518dcdffb51410def8eeecfc202c9eb3ecf65c0\", \"gin_unittests\": \"a41427eb2661d3944fabfca5f029a7b7ff10d472\", \"gl_unittests_ozone\": \"22eb02c7858dc0e36f126feedd22761b4f7d7182\", \"google_apis_unittests\": \"f2708d01883c4c8e9aaf06a46e97a7ac360b8dd0\", \"gpu_unittests\": \"2eafc0565a007c2e10b924e96ef7e66fe3e27e18\", \"gwp_asan_unittests\": \"f4e5ba1fc94656d1e991aa94feff4e4907192713\", \"interactive_ui_tests\": \"f2febd7b7a8ba359a40cd422cfe4d0d56fb446e2\", \"ipc_tests\": \"22e8db4bc27b19430b200d4f341e46a61e4640eb\", \"jingle_unittests\": \"cc348445ade65f35e06799abf0a5bf91beb82c11\", \"keyboard_unittests\": \"cf60effd3c773eb6e2e21fb3f74c46684fc3cb28\", \"latency_unittests\": \"9984acbb1b20b2b3a0123c3f05a776e6a703fb33\", \"libjingle_xmpp_unittests\": \"a9c5c11c7f4fe3c088340db2ffd677576f93f566\", \"liburlpattern_unittests\": \"bca283de7b30d842813cc79c295fd68932b4a955\", \"media_blink_unittests\": \"1ed51a940236faf1ca2fc4ea3cabd9a15bb270b7\", \"media_unittests\": \"b99844706441c5a8e5205e19f809ee8181b774aa\", \"message_center_unittests\": \"a98590a262be10569b499dacbadde9d722222f7e\", \"midi_unittests\": \"2abc936c90a390e420a222d73bfe2ec3ced4132c\", \"mojo_core_unittests\": \"cf273783bef821585b1cee8d2a3897a29627d660\", \"mojo_unittests\": \"7f64c9bde09ded9445be64a939f22b3247b695a1\", \"nacl_helper_nonsfi_unittests\": \"d070065adf5795494e109db714518edc38b6aed4\", \"nacl_loader_unittests\": \"fbb31c11477db9e034f4e0cf85b92737c4d32617\", \"native_theme_unittests\": \"e1767b448c26909d91d0b644b772e148a6cdcf7c\", \"net_unittests\": \"b4a4796f1dc79e81b1f738df2d0a888bc442cc0d\", \"ozone_gl_unittests\": \"53b11ffde2ab6b67d20d1f04f359a07411a275bc\", \"ozone_unittests\": \"742b3569c0e7118f0e677631413cc1be1a40a299\", \"ozone_x11_unittests\": \"260f870a1116827b369f3b135e37b10484583289\", \"pdf_unittests\": \"f9b9587fbf71e7f0004d62903e8050fb5be21f8d\", \"perfetto_unittests\": \"ed939d57478589f8abc454d8711ad799e64ece89\", \"ppapi_unittests\": \"3a64183e9a7564d65e3b232908d29021e0f39577\", \"printing_unittests\": \"b42c20954efa65bacaae59ee4e3d5d3b2e499b46\", \"remoting_unittests\": \"cf9c9b2eaaeaef312f23964d2ed769ec0a255755\", \"sandbox_linux_unittests\": \"c13361c1da0f5a6d8caf8a81ccd431db9650e0a9\", \"service_manager_unittests\": \"b099caaa8feaf7b9e123cc4343e663fc4af66f9f\", \"services_unittests\": \"ab9ad7c615d8dbc7b49c60b06c7ad86a27d78377\", \"shell_dialogs_unittests\": \"1e967656c2fd58a51c2a88b264a7db58414e3817\", \"shell_encryption_unittests\": \"ab8e4f3bfd48025be0186890e113c4cf68f1b83a\", \"skia_unittests\": \"e3738c43908586c9abf5665e915d9c35a28a9fd8\", \"snapshot_unittests\": \"cbd0d95d920c6965c9c36b41d8cfdbf7aecd434d\", \"sql_unittests\": \"da056251ac954fb296c71f98e8bdc5986bb27f5d\", \"storage_unittests\": \"84a2b1189c1a9b93a05dba01b1e9f5277894f99d\", \"sync_integration_tests\": \"05888450904cd95f2eb7a8ad3b4ba2ef10a0e4f9\", \"traffic_annotation_auditor_unittests\": \"f62babcbab6da03b9ba006504b3a9e7259281f95\", \"ui_base_unittests\": \"37ce644ea434af2cf5e8823345ee087650f1e4de\", \"ui_chromeos_unittests\": \"6a2b9dedfd98b80e20c78f3aa6550ffb6cefafe3\", \"ui_touch_selection_unittests\": \"25eadeda300f7bb94b765fcb6fe04ec21597094a\", \"unit_tests\": \"94f3929ce5e409f0e4b6c235ead3e3f19e29b586\", \"url_unittests\": \"1e2c00b8acfc12c8f4d3a0732fff1e2d921a60f0\", \"usage_time_limit_unittests\": \"12fdb70395d116615beda9f5881637b72dc51c82\", \"views_unittests\": \"102cfa00eefa2e17444ac67689865c52d9733149\", \"viz_unittests\": \"b25ca1c332e8412f1591dde9193018bf20dcfbd1\", \"wayland_client_perftests\": \"30c49b01cc8f0ad950347db1cbe26dcb931e7973\", \"wayland_client_tests\": \"c186f10a166a7d684b24de7fb7c694e681b4fffc\", \"wm_unittests\": \"88083bc4047fd87e2ea7493c6e8e2fdf2c0b09e2\", \"wtf_unittests\": \"134ee8397e81afc75c20e9a3d5b70c83a53ec750\", \"zlib_unittests\": \"71c2eba5c7baeead160a0be5bb1501459750cc86\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_5ae174071c5d6730648bf4e0d5db68d27bfbde0d9c5b879a557aa1bc8e90c36b_v2\", \"builder_70f3607e3f7d84b5c3698c0eed74813ee5c700477d5aec13835ae2ecc5ee2d5b_v2\", \"builder_84395cd86c4615c28c38755187d54d1bbe2dcea268d302d74191d04ce3a055d0_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_9838cdda7ce687c7684fc9aeb747e1ca22b2df2997b41b43dd2b0c36b546a1ad_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-4-610t\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615840474278571",
"status": "COMPLETED",
"status_changed_ts": "1615843935087428",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46164",
"builder:linux-chromeos-rel",
"buildset:commit/git/f816ae0392547a30dcc1beaeb3b904a4d0bae321",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f816ae0392547a30dcc1beaeb3b904a4d0bae321",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018092296076324976",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852662234033667424/+/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:525069a57e3cb010",
"user_agent:luci-scheduler"
],
"updated_ts": "1615843935096863",
"url": "https://ci.chromium.org/b/8852662234033667424",
"utcnow_ts": "1615843935746133"
}
}
[21:32:15.761] Invocation finished in 58m39.30283393s with status SUCCEEDED