[11:39:24.548] New invocation is queued and will start shortly
[11:39:25.877] Starting the invocation (attempt 1)
[11:39:25.957] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:39:25.959] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:39:25.959] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019847247327866400",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4c45ae6e634481ef4a976813ab2d819a5e1bb4db\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9019847247327866400",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/4c45ae6e634481ef4a976813ab2d819a5e1bb4db",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4c45ae6e634481ef4a976813ab2d819a5e1bb4db",
"gitiles_ref:refs/heads/master"
]
}
[11:39:27.023] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1614166766096573",
"id": "8854417185032620960",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4c45ae6e634481ef4a976813ab2d819a5e1bb4db\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614166766778040",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45692",
"builder:linux-chromeos-rel",
"buildset:commit/git/4c45ae6e634481ef4a976813ab2d819a5e1bb4db",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4c45ae6e634481ef4a976813ab2d819a5e1bb4db",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019847247327866400",
"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/8854417185032620960/+/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": "1614166766778180",
"url": "https://ci.chromium.org/b/8854417185032620960",
"utcnow_ts": "1614166767016155"
}
}
[11:39:27.023] Task URL: https://ci.chromium.org/b/8854417185032620960
[11:39:27.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:2:0) after 1m0s
[11:40:27.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:2:0)
[11:40:27.076] Timer tick, asking Buildbucket for the build status
[11:40:27.198] Build 8854417185032620960: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[11:40:27.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:3:0) after 1m0s
[11:40:51.894] Received PubSub notification, asking Buildbucket for the build status
[11:40:51.967] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:27.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:3:0)
[11:41:27.247] Timer tick, asking Buildbucket for the build status
[11:41:27.340] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:27.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:5:0) after 1m0s
[11:42:27.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:5:0)
[11:42:27.385] Timer tick, asking Buildbucket for the build status
[11:42:27.485] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:27.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:6:0) after 1m0s
[11:43:27.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:6:0)
[11:43:27.527] Timer tick, asking Buildbucket for the build status
[11:43:27.618] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:27.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:7:0) after 1m0s
[11:44:27.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:7:0)
[11:44:27.652] Timer tick, asking Buildbucket for the build status
[11:44:27.894] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:27.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:8:0) after 1m0s
[11:45:27.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:8:0)
[11:45:27.999] Timer tick, asking Buildbucket for the build status
[11:45:28.113] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:28.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:9:0) after 1m0s
[11:46:28.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:9:0)
[11:46:28.173] Timer tick, asking Buildbucket for the build status
[11:46:28.249] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:28.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:10:0) after 1m0s
[11:47:28.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:10:0)
[11:47:28.277] Timer tick, asking Buildbucket for the build status
[11:47:28.370] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:28.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:11:0) after 1m0s
[11:48:28.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:11:0)
[11:48:28.350] Timer tick, asking Buildbucket for the build status
[11:48:28.436] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:28.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:12:0) after 1m0s
[11:49:28.587] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:12:0)
[11:49:28.587] Timer tick, asking Buildbucket for the build status
[11:49:28.688] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:28.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:13:0) after 1m0s
[11:50:28.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:13:0)
[11:50:28.857] Timer tick, asking Buildbucket for the build status
[11:50:28.923] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:28.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:14:0) after 1m0s
[11:51:28.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:14:0)
[11:51:28.971] Timer tick, asking Buildbucket for the build status
[11:51:29.047] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:29.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:15:0) after 1m0s
[11:52:29.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:15:0)
[11:52:29.141] Timer tick, asking Buildbucket for the build status
[11:52:29.251] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:29.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:16:0) after 1m0s
[11:53:29.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:16:0)
[11:53:29.435] Timer tick, asking Buildbucket for the build status
[11:53:29.514] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:29.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:17:0) after 1m0s
[11:54:29.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:17:0)
[11:54:29.623] Timer tick, asking Buildbucket for the build status
[11:54:29.820] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:29.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:18:0) after 1m0s
[11:55:29.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:18:0)
[11:55:29.873] Timer tick, asking Buildbucket for the build status
[11:55:30.011] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:30.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:19:0) after 1m0s
[11:56:30.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:19:0)
[11:56:30.102] Timer tick, asking Buildbucket for the build status
[11:56:30.263] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:30.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:20:0) after 1m0s
[11:57:30.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:20:0)
[11:57:30.261] Timer tick, asking Buildbucket for the build status
[11:57:30.359] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:30.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:21:0) after 1m0s
[11:58:44.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:21:0)
[11:58:44.342] Timer tick, asking Buildbucket for the build status
[11:58:44.456] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:44.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:22:0) after 1m0s
[11:59:44.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:22:0)
[11:59:44.682] Timer tick, asking Buildbucket for the build status
[11:59:44.875] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:44.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:23:0) after 1m0s
[12:00:44.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:23:0)
[12:00:44.936] Timer tick, asking Buildbucket for the build status
[12:00:45.097] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:45.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:24:0) after 1m0s
[12:01:45.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:24:0)
[12:01:45.163] Timer tick, asking Buildbucket for the build status
[12:01:47.253] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:47.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:25:0) after 1m0s
[12:02:47.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:25:0)
[12:02:47.273] Timer tick, asking Buildbucket for the build status
[12:02:47.559] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:47.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:26:0) after 1m0s
[12:03:47.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:26:0)
[12:03:47.570] Timer tick, asking Buildbucket for the build status
[12:03:47.670] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:47.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:27:0) after 1m0s
[12:04:47.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:27:0)
[12:04:47.724] Timer tick, asking Buildbucket for the build status
[12:04:48.762] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:48.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:28:0) after 1m0s
[12:05:49.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:28:0)
[12:05:49.073] Timer tick, asking Buildbucket for the build status
[12:05:49.151] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:49.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:29:0) after 1m0s
[12:06:49.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:29:0)
[12:06:49.330] Timer tick, asking Buildbucket for the build status
[12:06:49.552] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:49.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:30:0) after 1m0s
[12:07:49.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:30:0)
[12:07:49.761] Timer tick, asking Buildbucket for the build status
[12:07:50.008] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:50.008] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:31:0) after 1m0s
[12:08:50.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:31:0)
[12:08:50.734] Timer tick, asking Buildbucket for the build status
[12:08:50.882] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:50.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:32:0) after 1m0s
[12:09:51.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:32:0)
[12:09:51.086] Timer tick, asking Buildbucket for the build status
[12:09:51.572] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:51.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:33:0) after 1m0s
[12:10:51.726] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:33:0)
[12:10:51.726] Timer tick, asking Buildbucket for the build status
[12:10:51.989] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:51.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:34:0) after 1m0s
[12:11:52.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:34:0)
[12:11:52.055] Timer tick, asking Buildbucket for the build status
[12:11:52.145] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:52.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:35:0) after 1m0s
[12:12:52.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:35:0)
[12:12:52.266] Timer tick, asking Buildbucket for the build status
[12:12:52.376] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:52.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:36:0) after 1m0s
[12:13:52.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:36:0)
[12:13:52.387] Timer tick, asking Buildbucket for the build status
[12:13:52.555] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:52.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:37:0) after 1m0s
[12:14:52.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:37:0)
[12:14:52.624] Timer tick, asking Buildbucket for the build status
[12:14:53.821] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:53.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:38:0) after 1m0s
[12:15:53.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:38:0)
[12:15:53.889] Timer tick, asking Buildbucket for the build status
[12:15:54.294] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:54.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:39:0) after 1m0s
[12:16:54.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:39:0)
[12:16:54.347] Timer tick, asking Buildbucket for the build status
[12:16:54.594] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:54.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:40:0) after 1m0s
[12:17:54.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:40:0)
[12:17:54.653] Timer tick, asking Buildbucket for the build status
[12:17:54.742] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:54.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:41:0) after 1m0s
[12:18:54.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:41:0)
[12:18:54.859] Timer tick, asking Buildbucket for the build status
[12:18:54.948] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:54.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:42:0) after 1m0s
[12:19:55.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:42:0)
[12:19:55.009] Timer tick, asking Buildbucket for the build status
[12:19:55.102] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:55.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:43:0) after 1m0s
[12:20:55.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:43:0)
[12:20:55.147] Timer tick, asking Buildbucket for the build status
[12:20:55.237] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:55.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:44:0) after 1m0s
[12:21:55.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:44:0)
[12:21:55.238] Timer tick, asking Buildbucket for the build status
[12:21:55.325] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:55.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:45:0) after 1m0s
[12:22:55.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:45:0)
[12:22:55.348] Timer tick, asking Buildbucket for the build status
[12:22:55.467] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:55.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:46:0) after 1m0s
[12:23:55.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:46:0)
[12:23:55.442] Timer tick, asking Buildbucket for the build status
[12:23:58.147] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:58.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:47:0) after 1m0s
[12:24:58.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:47:0)
[12:24:58.123] Timer tick, asking Buildbucket for the build status
[12:24:58.890] Build 8854417185032620960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:58.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9019847247327866400:48:0) after 1m0s
[12:25:52.285] Received PubSub notification, asking Buildbucket for the build status
[12:25:52.772] Build 8854417185032620960: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:25:52.772] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1614169551113596",
"created_by": "project:chromium",
"created_ts": "1614166766096573",
"id": "8854417185032620960",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4c45ae6e634481ef4a976813ab2d819a5e1bb4db\"}}",
"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\": \"4c45ae6e634481ef4a976813ab2d819a5e1bb4db\", \"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-82-eeu9\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45692, \"got_angle_revision\": \"d81e5d17b26ad7a401c764bacdfd96604eac8802\", \"got_dawn_revision\": \"d67544797e54d3866f378c2a7c05181db552f125\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"4c45ae6e634481ef4a976813ab2d819a5e1bb4db\", \"got_revision_cp\": \"refs/heads/master@{#857106}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"22186f076bf3bbe1a818792bde93b297e3773f7e\", \"got_v8_revision\": \"27931735fc4450a71eacf39ce96e46f47e1c0acf\", \"got_v8_revision_cp\": \"refs/heads/9.0.252@{#1}\", \"got_webrtc_revision\": \"d0844a80deaab28d7df8e5dff9f71e6ab6919025\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33323}\", \"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\": \"4c45ae6e634481ef4a976813ab2d819a5e1bb4db\", \"swarm_hashes_refs/heads/master(at){#857106}_without_patch\": {\"absl_hardening_tests\": \"14fdd353a0f5aac3256d188a681018794fd1820f\", \"accessibility_unittests\": \"4ffe9baed854b78213c793a18ef4206bf4638a14\", \"angle_unittests\": \"6385343b66fdaa06d60d759c9523dd68d5d91f30\", \"app_list_unittests\": \"dd02a6f4d54557e67503b58e5150927c65dfcf8e\", \"app_shell_unittests\": \"29460ee13c3b9fb74ee481661a203fb852c71284\", \"ash_unittests\": \"9bece3c505fbfd8e1444bbcd6cc90df7846ef42a\", \"aura_unittests\": \"da999b3c049eb63390de19bb085c1bf98a300315\", \"base_unittests\": \"e8688f150ff3d942a63ca805dc7c0213ef8e6f21\", \"base_util_unittests\": \"6f8b61b0f4ee43884295995d1fde719273278c69\", \"blink_common_unittests\": \"0197b05c4c683cd40d3cd0290464c40b9c5983dc\", \"blink_fuzzer_unittests\": \"c45c73d432a0aee3135831307e2a9a243551b1ef\", \"blink_heap_unittests\": \"d90176c14d784db0fe9cde994e35e03c268de042\", \"blink_platform_unittests\": \"cf7afd41fba8a6cb55ae8ce9ab679338538d1e5b\", \"blink_unittests\": \"4c83631faa9fa27a43cdf675b2ba4a06a4e519eb\", \"boringssl_crypto_tests\": \"a041e2d1841edd944b8010f9609e45748165c868\", \"boringssl_ssl_tests\": \"8d7a9f58ed7a0b4021a7c65a7ce59086ec07d3e2\", \"browser_tests\": \"fffed6a463582de7b6edf3c0942fb003786f12f9\", \"capture_unittests\": \"4585382ebd76fdeed314f258bcf593b641ef8d9c\", \"cast_unittests\": \"bcf9186e48dd5acc981fd6f1c833f2f23da572a3\", \"cc_unittests\": \"610536422dce11eae8ed1833aa6f3f5836db514d\", \"chrome_app_unittests\": \"7f9f0986e11a0540b22f3592c5787ef4498f0a6f\", \"chromedriver_unittests\": \"2a7c7053e565f8651c2364edbae93ce4c6f56161\", \"chromeos_components_unittests\": \"47a3aa1be84351709b658569d5ff54ae0b579f2c\", \"chromeos_unittests\": \"fe7bb223a1018a30371f0e3b1f026a595e774fb9\", \"color_unittests\": \"137faf93ac816435fcc72eb05278eb990a3f3b53\", \"components_browsertests\": \"46004c0a65608d272c8227365e3d30b6eac47f6f\", \"components_unittests\": \"3bb02f63bb2de649598e7c025b4b567368c16952\", \"compositor_unittests\": \"ae9f8225f94fb68f3aa3185ddb8a230eee622b42\", \"content_browsertests\": \"ee613f66525226ce53e54639a98d5997407f66a4\", \"content_unittests\": \"51ade813742938c536774119943bd73d3d0f400a\", \"crashpad_tests\": \"57880b9e05e9f4210356c2fe8425c77b6a7af301\", \"crypto_unittests\": \"1578e0c5c575a729c523655a3278151ed743ba2c\", \"dbus_unittests\": \"593cbb0c358b849061f71d5d3f802a341bc25feb\", \"device_unittests\": \"9d12b82a2a2409dcc45545fcff7e376318e5a704\", \"display_unittests\": \"f610a5690460eecab8ce2c2fc1ed125bfb310b1d\", \"events_unittests\": \"e4fa16e100d6014b8c9dec2f76023e2bbab72191\", \"exo_unittests\": \"db1867bc7ffdb7e69716325a801c4a2d76f0667a\", \"extensions_browsertests\": \"107e9547930f60019fb0f9aecfa34ca63363a06c\", \"extensions_unittests\": \"bf38e5c77607197ce5cdefa1ab7efea4598bc3fc\", \"filesystem_service_unittests\": \"15c1a1791528e07487b4a8522a9892235f2206a1\", \"gcm_unit_tests\": \"d3e1ce35e64a7722512ff0ec5726a3692780a1e0\", \"gfx_unittests\": \"85908bca79c454f44ef08c3887b42ca8ba280102\", \"gin_unittests\": \"3e876e738fc3c9ef76bd69debb2b604918284909\", \"gl_unittests_ozone\": \"1f4601e1b0e7e706b89404dfbaf8f09ee1c12331\", \"google_apis_unittests\": \"3990039bbfb702dc16a6d2b6fb8c86a53ee01784\", \"gpu_unittests\": \"551aa2cb23539f6485de48e4a1e8b4af2d897f0d\", \"gwp_asan_unittests\": \"34332b788dc20e52f5f51761e4da17d8b29fc1c7\", \"interactive_ui_tests\": \"24b592c68d2e81756d42c7fc30da8ebe01576991\", \"ipc_tests\": \"b843648d15f1b22bb44b91b3f971bef35728516c\", \"jingle_unittests\": \"d331646b7ceb90eb4a3858f14d249206afd2b2a9\", \"keyboard_unittests\": \"0d5ddf2159de85527fa4a686a36846856fd4087e\", \"latency_unittests\": \"2856e24b27c77883936a8f065482dcca60626917\", \"libjingle_xmpp_unittests\": \"498900204bf9d065d1033a0966b51f39eccd3360\", \"liburlpattern_unittests\": \"dfe0aa189bf7b1fa6476e9627305446206fa2869\", \"media_blink_unittests\": \"99294cfce18da4fb8e23279b0702e92f87a7a707\", \"media_unittests\": \"870800e1be619dfbc0ddce80165e9a1d455bdabb\", \"message_center_unittests\": \"d785f7d4c512503d17e06a1844c2cdbc3584fb66\", \"midi_unittests\": \"82a5e74837207a1f8fb6f7e4d5e2f34a7ee56293\", \"mojo_core_unittests\": \"153379a248ff5a4d212d3e841ebb893a3cdeed3b\", \"mojo_unittests\": \"c0dd4b402d6704ab12a059cde42538e6dbe11e56\", \"nacl_helper_nonsfi_unittests\": \"322f42ac61e8c7bec0e6e64702359ab17782e73c\", \"nacl_loader_unittests\": \"67034b0f70ac24ed7d384415c9d7efd88ca7e445\", \"native_theme_unittests\": \"985840e06b8684d67df9688fabf5a1ea67c4d67e\", \"net_unittests\": \"d9df22df00132e05c4c81438375ebd151dea1ca8\", \"ozone_gl_unittests\": \"9755b88af658860e97a7bb9cc2b0fe1214d2a449\", \"ozone_unittests\": \"cd1f171cde8d66fa3433ada542889dd1d5280892\", \"ozone_x11_unittests\": \"1d5e51825846c9f1dbd53fce8b4e031124fb27f9\", \"pdf_unittests\": \"3f4dbffb384774b35ea0cb54244fc3a707a558d4\", \"perfetto_unittests\": \"9afd000696efef036a6a2f50afe21fda03af1a56\", \"ppapi_unittests\": \"96b81923c2820c3b48de167a59134457eb09be71\", \"printing_unittests\": \"a5cadacee9df27f66b93eb571f809442b02efa2d\", \"remoting_unittests\": \"aada4072c7cd041b2855d434849ec7b81b5a1d35\", \"sandbox_linux_unittests\": \"fce57e6c1eb508095e156325f19df05ff1755724\", \"service_manager_unittests\": \"41da51c0c558e0a427da99565731b48c32b767bf\", \"services_unittests\": \"1266f53451ea413e982772aee768a065bd8384aa\", \"shell_dialogs_unittests\": \"837a48adb97f7b31f97a075fcc7e00bffdb687b8\", \"shell_encryption_unittests\": \"e9aca797077ffb202a9875d4878fd2bc963cc257\", \"skia_unittests\": \"1a989958e422d36bf45c21d535d46ce16388da1f\", \"snapshot_unittests\": \"fcebb658b5bf7c38affa8a037f71cdbaa466d741\", \"sql_unittests\": \"a94f388c28e5a3b78683c9cbe5ca9ff522c70ed7\", \"storage_unittests\": \"ee5144fddecba8cb83e62ebf4e79612b17159807\", \"sync_integration_tests\": \"b8aa4564141be2308561bda9417bfcccd8554e2c\", \"traffic_annotation_auditor_unittests\": \"575b4840f15865c192b1b4a10b0657b1d1a1b546\", \"ui_base_unittests\": \"e6d2eda6b10593314e1fa32f1a6353a4abecd663\", \"ui_chromeos_unittests\": \"dd51e9e0a57f60b3c1fb088d5d9593e35bcaef59\", \"ui_touch_selection_unittests\": \"27ef99b3cc2de6129faffeb7cb6a07e0be9fbc0c\", \"unit_tests\": \"2d9c3f207afa155a633a5d127b2d19aededa7ba0\", \"url_unittests\": \"f1c9ccb33c822995257e10b00ac2d58a9e010368\", \"usage_time_limit_unittests\": \"2ef085db5bce05a51df80b1db867f50f8cbce4a8\", \"views_unittests\": \"1a4f9cab3dcd7319a17f49306fec9f7206bedaec\", \"viz_unittests\": \"e09665dbdca6d9bc7f71ca4516b5c04c51f11f62\", \"wayland_client_perftests\": \"f54af94f6a9f92a683efe9f8ebc670d84f5edb47\", \"wm_unittests\": \"a86ee9e09fae43e607a61092fa7599cb7a9eec3b\", \"wtf_unittests\": \"3e24076da6dc5f6ff841a95c9764d77ffd3a8091\", \"zlib_unittests\": \"a42ac3e3d5d0d19c295beee3fd89c4e0d49ad59f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4a782824ba39c0c6a32b2128ebb0687e83cb58dc0cbed64e2911b02f7893cfe6_v2\", \"builder_53a369b6e7b3f2409540d71b27a68c8bcf1cb73633e70dba0b4b8b173a0aec5e_v2\", \"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_9f247f4686c5cf47ea762220cc037b3e853f43c1442c10d387faa806e919f9a9_v2\", \"builder_c9091f6bc58db7983401393b6dacc93b3db8fae2c2ae9b40177b9e0904c8bc80_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_e9d7d0a19fc068adf341a224b6eb4c464e3f53ed9d47979ef0c80d8aa2ba711c_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-82-eeu9\"], \"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\": [\"5709-d3c4474\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614166850834674",
"status": "COMPLETED",
"status_changed_ts": "1614169551801354",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45692",
"builder:linux-chromeos-rel",
"buildset:commit/git/4c45ae6e634481ef4a976813ab2d819a5e1bb4db",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4c45ae6e634481ef4a976813ab2d819a5e1bb4db",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019847247327866400",
"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/8854417185032620960/+/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:51eca7bfca6e3410",
"user_agent:luci-scheduler"
],
"updated_ts": "1614169551806602",
"url": "https://ci.chromium.org/b/8854417185032620960",
"utcnow_ts": "1614169552763828"
}
}
[12:25:52.772] Invocation finished in 46m28.248607918s with status SUCCEEDED