[08:27:59.341] New invocation is queued and will start shortly
[08:28:00.609] Starting the invocation (attempt 1)
[08:28:00.639] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:28:00.639] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:28:00.639] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018590932902319760",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0385ffbfe47191ea609f0ce5df3a1599f10697fb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9018590932902319760",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/0385ffbfe47191ea609f0ce5df3a1599f10697fb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0385ffbfe47191ea609f0ce5df3a1599f10697fb",
"gitiles_ref:refs/heads/master"
]
}
[08:28:01.211] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615364880710366",
"id": "8853160870803153472",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0385ffbfe47191ea609f0ce5df3a1599f10697fb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615364881072157",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46045",
"builder:linux-chromeos-rel",
"buildset:commit/git/0385ffbfe47191ea609f0ce5df3a1599f10697fb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0385ffbfe47191ea609f0ce5df3a1599f10697fb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018590932902319760",
"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/8853160870803153472/+/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": "1615364881072264",
"url": "https://ci.chromium.org/b/8853160870803153472",
"utcnow_ts": "1615364881202480"
}
}
[08:28:01.211] Task URL: https://ci.chromium.org/b/8853160870803153472
[08:28:01.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:2:0) after 1m0s
[08:28:04.306] Received PubSub notification, asking Buildbucket for the build status
[08:28:04.377] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:01.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:2:0)
[08:29:01.211] Timer tick, asking Buildbucket for the build status
[08:29:01.340] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:01.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:4:0) after 1m0s
[08:30:01.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:4:0)
[08:30:01.658] Timer tick, asking Buildbucket for the build status
[08:30:01.957] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:01.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:5:0) after 1m0s
[08:31:01.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:5:0)
[08:31:01.997] Timer tick, asking Buildbucket for the build status
[08:31:02.212] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:02.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:6:0) after 1m0s
[08:32:02.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:6:0)
[08:32:02.239] Timer tick, asking Buildbucket for the build status
[08:32:02.297] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:02.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:7:0) after 1m0s
[08:33:02.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:7:0)
[08:33:02.295] Timer tick, asking Buildbucket for the build status
[08:33:02.376] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:02.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:8:0) after 1m0s
[08:34:02.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:8:0)
[08:34:02.433] Timer tick, asking Buildbucket for the build status
[08:34:02.556] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:02.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:9:0) after 1m0s
[08:35:02.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:9:0)
[08:35:02.564] Timer tick, asking Buildbucket for the build status
[08:35:02.702] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:02.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:10:0) after 1m0s
[08:36:02.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:10:0)
[08:36:02.748] Timer tick, asking Buildbucket for the build status
[08:36:03.035] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:03.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:11:0) after 1m0s
[08:37:03.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:11:0)
[08:37:03.049] Timer tick, asking Buildbucket for the build status
[08:37:03.129] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:03.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:12:0) after 1m0s
[08:38:03.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:12:0)
[08:38:03.144] Timer tick, asking Buildbucket for the build status
[08:38:03.728] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:03.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:13:0) after 1m0s
[08:39:03.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:13:0)
[08:39:03.813] Timer tick, asking Buildbucket for the build status
[08:39:03.892] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:03.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:14:0) after 1m0s
[08:40:03.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:14:0)
[08:40:03.933] Timer tick, asking Buildbucket for the build status
[08:40:04.016] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:04.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:15:0) after 1m0s
[08:41:04.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:15:0)
[08:41:04.356] Timer tick, asking Buildbucket for the build status
[08:41:04.432] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:04.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:16:0) after 1m0s
[08:42:04.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:16:0)
[08:42:04.489] Timer tick, asking Buildbucket for the build status
[08:42:04.706] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:04.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:17:0) after 1m0s
[08:43:04.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:17:0)
[08:43:04.772] Timer tick, asking Buildbucket for the build status
[08:43:04.869] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:04.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:18:0) after 1m0s
[08:44:04.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:18:0)
[08:44:04.921] Timer tick, asking Buildbucket for the build status
[08:44:05.105] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:05.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:19:0) after 1m0s
[08:45:05.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:19:0)
[08:45:05.108] Timer tick, asking Buildbucket for the build status
[08:45:05.229] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:05.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:20:0) after 1m0s
[08:46:05.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:20:0)
[08:46:05.245] Timer tick, asking Buildbucket for the build status
[08:46:05.313] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:05.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:21:0) after 1m0s
[08:47:05.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:21:0)
[08:47:05.324] Timer tick, asking Buildbucket for the build status
[08:47:05.398] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:05.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:22:0) after 1m0s
[08:48:05.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:22:0)
[08:48:05.447] Timer tick, asking Buildbucket for the build status
[08:48:05.613] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:05.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:23:0) after 1m0s
[08:49:05.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:23:0)
[08:49:05.643] Timer tick, asking Buildbucket for the build status
[08:49:06.111] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:06.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:24:0) after 1m0s
[08:50:06.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:24:0)
[08:50:06.198] Timer tick, asking Buildbucket for the build status
[08:50:06.313] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:06.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:25:0) after 1m0s
[08:51:06.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:25:0)
[08:51:06.315] Timer tick, asking Buildbucket for the build status
[08:51:06.412] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:06.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:26:0) after 1m0s
[08:52:06.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:26:0)
[08:52:06.477] Timer tick, asking Buildbucket for the build status
[08:52:06.534] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:06.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:27:0) after 1m0s
[08:53:06.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:27:0)
[08:53:06.569] Timer tick, asking Buildbucket for the build status
[08:53:06.706] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:06.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:28:0) after 1m0s
[08:54:06.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:28:0)
[08:54:06.736] Timer tick, asking Buildbucket for the build status
[08:54:06.804] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:06.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:29:0) after 1m0s
[08:55:06.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:29:0)
[08:55:06.857] Timer tick, asking Buildbucket for the build status
[08:55:07.043] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:07.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:30:0) after 1m0s
[08:56:07.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:30:0)
[08:56:07.069] Timer tick, asking Buildbucket for the build status
[08:56:07.156] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:07.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:31:0) after 1m0s
[08:57:07.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:31:0)
[08:57:07.200] Timer tick, asking Buildbucket for the build status
[08:57:07.332] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:07.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:32:0) after 1m0s
[08:58:07.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:32:0)
[08:58:07.402] Timer tick, asking Buildbucket for the build status
[08:58:07.709] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:07.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:33:0) after 1m0s
[08:59:07.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:33:0)
[08:59:07.749] Timer tick, asking Buildbucket for the build status
[08:59:07.865] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:07.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:34:0) after 1m0s
[09:00:07.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:34:0)
[09:00:07.938] Timer tick, asking Buildbucket for the build status
[09:00:08.046] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:08.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:35:0) after 1m0s
[09:01:08.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:35:0)
[09:01:08.111] Timer tick, asking Buildbucket for the build status
[09:01:08.232] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:08.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:36:0) after 1m0s
[09:02:08.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:36:0)
[09:02:08.265] Timer tick, asking Buildbucket for the build status
[09:02:08.355] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:08.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:37:0) after 1m0s
[09:03:08.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:37:0)
[09:03:08.457] Timer tick, asking Buildbucket for the build status
[09:03:08.579] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:08.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:38:0) after 1m0s
[09:04:08.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:38:0)
[09:04:08.793] Timer tick, asking Buildbucket for the build status
[09:04:08.878] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:08.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:39:0) after 1m0s
[09:05:08.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:39:0)
[09:05:08.955] Timer tick, asking Buildbucket for the build status
[09:05:09.028] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:09.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:40:0) after 1m0s
[09:06:09.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:40:0)
[09:06:09.052] Timer tick, asking Buildbucket for the build status
[09:06:09.229] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:09.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:41:0) after 1m0s
[09:07:09.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:41:0)
[09:07:09.291] Timer tick, asking Buildbucket for the build status
[09:07:09.364] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:09.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:42:0) after 1m0s
[09:08:09.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:42:0)
[09:08:09.406] Timer tick, asking Buildbucket for the build status
[09:08:09.728] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:09.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:43:0) after 1m0s
[09:09:09.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:43:0)
[09:09:09.717] Timer tick, asking Buildbucket for the build status
[09:09:09.831] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:09.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:44:0) after 1m0s
[09:10:09.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:44:0)
[09:10:09.881] Timer tick, asking Buildbucket for the build status
[09:10:10.147] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:10.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:45:0) after 1m0s
[09:11:10.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:45:0)
[09:11:10.153] Timer tick, asking Buildbucket for the build status
[09:11:10.224] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:10.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:46:0) after 1m0s
[09:12:10.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:46:0)
[09:12:10.265] Timer tick, asking Buildbucket for the build status
[09:12:10.639] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:10.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:47:0) after 1m0s
[09:13:10.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:47:0)
[09:13:10.704] Timer tick, asking Buildbucket for the build status
[09:13:11.044] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:11.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:48:0) after 1m0s
[09:14:11.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:48:0)
[09:14:11.062] Timer tick, asking Buildbucket for the build status
[09:14:11.418] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:11.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:49:0) after 1m0s
[09:15:11.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:49:0)
[09:15:11.447] Timer tick, asking Buildbucket for the build status
[09:15:11.566] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:11.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:50:0) after 1m0s
[09:16:11.655] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:50:0)
[09:16:11.655] Timer tick, asking Buildbucket for the build status
[09:16:12.238] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:12.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:51:0) after 1m0s
[09:17:12.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:51:0)
[09:17:12.240] Timer tick, asking Buildbucket for the build status
[09:17:12.341] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:12.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:52:0) after 1m0s
[09:18:12.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:52:0)
[09:18:12.385] Timer tick, asking Buildbucket for the build status
[09:18:12.472] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:12.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:53:0) after 1m0s
[09:19:12.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:53:0)
[09:19:12.552] Timer tick, asking Buildbucket for the build status
[09:19:12.899] Build 8853160870803153472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:12.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018590932902319760:54:0) after 1m0s
[09:19:31.958] Received PubSub notification, asking Buildbucket for the build status
[09:19:32.334] Build 8853160870803153472: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:19:32.334] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615367971160509",
"created_by": "project:chromium",
"created_ts": "1615364880710366",
"id": "8853160870803153472",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0385ffbfe47191ea609f0ce5df3a1599f10697fb\"}}",
"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\": \"0385ffbfe47191ea609f0ce5df3a1599f10697fb\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-115-iywj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 46045, \"got_angle_revision\": \"c054008f9efb2f86a0bd6b8031e8c635c69107e4\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"0385ffbfe47191ea609f0ce5df3a1599f10697fb\", \"got_revision_cp\": \"refs/heads/master@{#861475}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"05696889ed8ad6708b18bdfbabe603d04a0d76da\", \"got_v8_revision_cp\": \"refs/heads/9.1.88@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"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\": \"0385ffbfe47191ea609f0ce5df3a1599f10697fb\", \"swarm_hashes_refs/heads/master(at){#861475}_without_patch\": {\"absl_hardening_tests\": \"a428ac0a22ffd01536441c1cb6e5c47c4e45d9df\", \"accessibility_unittests\": \"a4cc127d33401fe1077f995f8019a4850dc0f261\", \"angle_unittests\": \"eec213557b89bcda70053de38087210f8417578f\", \"app_list_unittests\": \"60ddf11fa0ae60bd1211a72b0e9b0e9ed39f8d21\", \"app_shell_unittests\": \"0a0dec9b5371de29dbcfc2e2d11640c44bc6ed9b\", \"ash_unittests\": \"ed2d2824467bb074d55dc8941b49189542e86764\", \"aura_unittests\": \"4a94c51ff2f23b82b4981fc552ed44fc476f5ce1\", \"base_unittests\": \"dad3e8b72cd9cc2d96efc0df9d4aeec766654e91\", \"base_util_unittests\": \"f92665e26a42ae91943307760abc3b562ebb1176\", \"blink_common_unittests\": \"e26fb96eb3c42bc59a1136d13d857e84ee158fb6\", \"blink_fuzzer_unittests\": \"2df8b4385accb69e961b67704d5576c76765a183\", \"blink_heap_unittests\": \"95cd3e473bc865c3d3a055c1ab0c529197bf87f0\", \"blink_platform_unittests\": \"b8a0ad02248edf16cb03df004583b9dd9c4253d3\", \"blink_unittests\": \"7998813972e49f7b1f942128b856744fd03ce729\", \"boringssl_crypto_tests\": \"f2d4154b6a5b758ab5e24eb473e91186186b98f1\", \"boringssl_ssl_tests\": \"c9492e2096194f62014dd592f4717dbec2a26f1e\", \"browser_tests\": \"71e2da3ab52ddc7ddc41d1ca5e10b8cf03fd0ab7\", \"capture_unittests\": \"a47f884c4249baf90d7a4c76a1b806e641f09fb0\", \"cast_unittests\": \"36560a95517db619e4bffd6a76c69032a9c30ae0\", \"cc_unittests\": \"3591ea94b7b0e9f28b7e0e6ad09a2c35a1f71dcf\", \"chrome_app_unittests\": \"669b8a9ab64bb2e866e769ddb0e54e72fe6cfded\", \"chromedriver_unittests\": \"6cacde43796cd590ca02cf24a779cdf34463f96a\", \"chromeos_components_unittests\": \"b65461a194dcbf799dfd471e1026df43af1b38e2\", \"chromeos_unittests\": \"aba0b1c7ebbf613dd51e0d0c6a6a0d43ca5e07d4\", \"color_unittests\": \"7d52c83e2bde03e365635c12de71c24c128b13fa\", \"components_browsertests\": \"28c1e2f307058a9a4cbb9afd151c8b81ccdb82e3\", \"components_unittests\": \"5f37e746a0a48776096b0dfdd89c3bfccd72d922\", \"compositor_unittests\": \"357bd732704266d355ff05ca1e105630836973ea\", \"content_browsertests\": \"faa8cb5aa6f35bbe23b92b4acc128e1f74fd1d6e\", \"content_unittests\": \"c7715338d991aadf091b28623d0e591c54b7afe0\", \"crashpad_tests\": \"7d73d904f5fb4edcbff179c8cca669cead415e83\", \"crypto_unittests\": \"298f973f9f372c94470562cedf50152ab6c7fc68\", \"dbus_unittests\": \"863f8e9306d3a4f5a8eade9e5c9fce9ff417a438\", \"device_unittests\": \"5e05ede45228debb88676595322e6230cc7c72f5\", \"display_unittests\": \"e2a71911d30b783066860a1f93e842049d3b15d4\", \"events_unittests\": \"39f41e5e5fea4b27619137ef6fd891842cea8a8d\", \"exo_unittests\": \"5c58701ac31a93908885155d12d6cfffed79955e\", \"extensions_browsertests\": \"4a74feab302599f5e5b927c1034ca68e68c7a915\", \"extensions_unittests\": \"0591b4b1b3a30fe880142c7b88c1b9020e4ad399\", \"filesystem_service_unittests\": \"1c90aa186fc86c3ab9e26f5c1bd541c34a038723\", \"gcm_unit_tests\": \"181bbd7805c981350efdee84bf3da9a7ca0fb389\", \"gfx_unittests\": \"eeda34db43910858cce8d493ee0cf7ba76bf6b07\", \"gin_unittests\": \"2f20efcc31b573bb0c2bdfefa6623fb31aab287b\", \"gl_unittests_ozone\": \"11eeb3a59aff5a9687666cf8b005dc8f6febaea4\", \"google_apis_unittests\": \"f9bc660bda179f6da307e012676e71735b7b2ffd\", \"gpu_unittests\": \"1802f297ac1d5d3a7ee2a60802dda6fd6f569ab7\", \"gwp_asan_unittests\": \"927c1b695690403c1621380faccfd5e38910601b\", \"interactive_ui_tests\": \"c2662c7176bf83b73ce4432e386d53d818272d6c\", \"ipc_tests\": \"49e723b91508fada7549c25f3100f8399846acad\", \"jingle_unittests\": \"196dca70c78875ae32fa6cd4adb3d386f941aa19\", \"keyboard_unittests\": \"9123ef65b256b0c39aeb2c3fe1c646f45d3415a2\", \"latency_unittests\": \"f1a42792910ad49a030f7191e6d5ec8902ffb20e\", \"libjingle_xmpp_unittests\": \"db9c879d5ffa92bf83ae21e2db84cda14d29c719\", \"liburlpattern_unittests\": \"e83b053f4b2ed1d56485963599b8a2a3bec78bd8\", \"media_blink_unittests\": \"365a62adbb5ed5d1e027c1312aa64984e7cb7696\", \"media_unittests\": \"ef015acd8017e4a75b871b34bc4ff643e622031d\", \"message_center_unittests\": \"3616ebb814ac07759439cc302bedf04578bb5667\", \"midi_unittests\": \"b296f535cc471aba10ef8b6af575f33fb164ef0e\", \"mojo_core_unittests\": \"2bbd831428ddc7abd946dc58e1bf88b619438290\", \"mojo_unittests\": \"a95d438745efa457811b27859738b2c57e2c25fd\", \"nacl_helper_nonsfi_unittests\": \"139ccf2b45f6254bcad9495a5da9826a6d6b8e16\", \"nacl_loader_unittests\": \"17dab30709b4213c28830c0992a52e2373c0fc30\", \"native_theme_unittests\": \"2a47a73bf7b913b0af8acc63eace4bc24b9f2e55\", \"net_unittests\": \"b03e325227999862c4bc0024b5b41cdf59b90f1e\", \"ozone_gl_unittests\": \"dedf83bc57aa737de3abc7b156df66e523e8bb69\", \"ozone_unittests\": \"9367ec21db80012c1a6bc7de0cbe0b2acbbd75f8\", \"ozone_x11_unittests\": \"57e9d3f253859bc4012f0638b79e66415ca76db3\", \"pdf_unittests\": \"3fad5b794af4421bfaad7ba12e1572dc3d8c54e3\", \"perfetto_unittests\": \"136070a1903c6831de89d038932838ff87d6d665\", \"ppapi_unittests\": \"73f1dbbe803ed748619c73bd1172347d41201f39\", \"printing_unittests\": \"3c645786ce2c4cd89ed5c68f3660089f504624af\", \"remoting_unittests\": \"4d9e1218ed5aff9664ca70aa6a9a507fd6762aa5\", \"sandbox_linux_unittests\": \"cf918d95fbbc3944c93918c0fe2be9b597b041c2\", \"service_manager_unittests\": \"4e8871a110c3760e2680f55185fae89887632b5c\", \"services_unittests\": \"ead4bb9735c7e2f0a5ede45e1a5bf4eb5f44eec8\", \"shell_dialogs_unittests\": \"5c95a5a9274d9a84f9fe92370b956934a6526d72\", \"shell_encryption_unittests\": \"a0276590fc1fc15ab849c2eeaff418555abddfbe\", \"skia_unittests\": \"84df1a84c1116772f4963795a97af449a38ab8c3\", \"snapshot_unittests\": \"53004a99c9247ae8a0de35c98e59b1d39439db2c\", \"sql_unittests\": \"25b9b5b587983cae29be13237048b32b02aba4c9\", \"storage_unittests\": \"6e101b5c758484f81819ea6350e04fb68a2fead1\", \"sync_integration_tests\": \"47433e329f84ef5f116260e9ec2165b481596724\", \"traffic_annotation_auditor_unittests\": \"5c0ed7ca67bfe5d9024df68a88a90c4f24615db0\", \"ui_base_unittests\": \"22d62a68692920b1155116901be577b20ea9c23e\", \"ui_chromeos_unittests\": \"7398b1423d87be72df8d7adadb314b8b4c374af3\", \"ui_touch_selection_unittests\": \"d7500d3af31ab619f24da546da67a21ccfda0b2b\", \"unit_tests\": \"0c7b3090ff51a486624d7ac6e140540ff5108d1e\", \"url_unittests\": \"70332102c4ec791b944fc8a9c19969b86edc70c8\", \"usage_time_limit_unittests\": \"fa9fd18774ecd50cc996829eae8d93bcb07ec389\", \"views_unittests\": \"57475b272fd7350be6376ec9883285f1bf2bc80f\", \"viz_unittests\": \"c857325f1dee9b6f20db4f8b8589c5c78982b2a7\", \"wayland_client_perftests\": \"23ab45ba91e358ef8f569604a9676695f4a85bcd\", \"wayland_client_tests\": \"f00461aa61b1f97f20b9b8702ad1b9af931bf544\", \"wm_unittests\": \"d4624f32b72fb173d2d8b11e3514754879efaa29\", \"wtf_unittests\": \"363a71e1024c0c1d886f8220ad8bebaf8556a720\", \"zlib_unittests\": \"1a855a3f0d1c0ce5f9a40dc26c8233d17d73d9b8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_256f5ddd0fd0dc12b292dc06910d383b36d434fcd402039f959c9b6741115c5c_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_5018db700e530f8e7ae860b5b3feab2b02d3dedf1bbd3e704c6c59fde1b308dd_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_99ff1ef652ee1a099e982d95872de1fdd74468ee6a8079168e46d4cfc0b2cfdf_v2\", \"builder_bbe6c22469d6b45d8f49350e3da0912e9331dc294c727d05ae5755d0a8b95710_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-115-iywj\"], \"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\": [\"5746-91ff3bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615364883876177",
"status": "COMPLETED",
"status_changed_ts": "1615367971585600",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46045",
"builder:linux-chromeos-rel",
"buildset:commit/git/0385ffbfe47191ea609f0ce5df3a1599f10697fb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0385ffbfe47191ea609f0ce5df3a1599f10697fb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018590932902319760",
"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/8853160870803153472/+/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:52341184966e3010",
"user_agent:luci-scheduler"
],
"updated_ts": "1615367971590624",
"url": "https://ci.chromium.org/b/8853160870803153472",
"utcnow_ts": "1615367972323927"
}
}
[09:19:32.334] Invocation finished in 51m33.010734363s with status SUCCEEDED