[05:12:28.076] New invocation is queued and will start shortly
[05:12:31.019] Starting the invocation (attempt 1)
[05:12:31.056] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:12:31.056] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:12:31.056] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031196212354751120",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"20a9ff5d0c01f4450a9becf622c6a5802ace6980\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9031196212354751120",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/20a9ff5d0c01f4450a9becf622c6a5802ace6980",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/20a9ff5d0c01f4450a9becf622c6a5802ace6980",
"gitiles_ref:refs/heads/master"
]
}
[05:12:31.631] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1603343551164641",
"id": "8865766148453343616",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"20a9ff5d0c01f4450a9becf622c6a5802ace6980\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603343551531948",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42164",
"builder:linux-chromeos-rel",
"buildset:commit/git/20a9ff5d0c01f4450a9becf622c6a5802ace6980",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/20a9ff5d0c01f4450a9becf622c6a5802ace6980",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031196212354751120",
"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/8865766148453343616/+/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": "1603343551532060",
"url": "https://ci.chromium.org/b/8865766148453343616",
"utcnow_ts": "1603343551623069"
}
}
[05:12:31.631] Task URL: https://ci.chromium.org/b/8865766148453343616
[05:12:31.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:2:0) after 1m0s
[05:12:33.255] Received PubSub notification, asking Buildbucket for the build status
[05:12:33.326] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:31.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:2:0)
[05:13:31.678] Timer tick, asking Buildbucket for the build status
[05:13:31.792] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:31.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:4:0) after 1m0s
[05:14:31.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:4:0)
[05:14:31.812] Timer tick, asking Buildbucket for the build status
[05:14:31.920] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:31.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:5:0) after 1m0s
[05:15:31.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:5:0)
[05:15:31.938] Timer tick, asking Buildbucket for the build status
[05:15:32.070] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:32.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:6:0) after 1m0s
[05:16:32.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:6:0)
[05:16:32.098] Timer tick, asking Buildbucket for the build status
[05:16:32.195] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:32.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:7:0) after 1m0s
[05:17:32.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:7:0)
[05:17:32.226] Timer tick, asking Buildbucket for the build status
[05:17:32.500] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:32.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:8:0) after 1m0s
[05:18:32.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:8:0)
[05:18:32.513] Timer tick, asking Buildbucket for the build status
[05:18:32.625] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:32.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:9:0) after 1m0s
[05:19:32.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:9:0)
[05:19:32.691] Timer tick, asking Buildbucket for the build status
[05:19:32.758] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:32.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:10:0) after 1m0s
[05:20:32.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:10:0)
[05:20:32.891] Timer tick, asking Buildbucket for the build status
[05:20:32.962] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:32.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:11:0) after 1m0s
[05:21:33.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:11:0)
[05:21:33.124] Timer tick, asking Buildbucket for the build status
[05:21:33.184] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:33.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:12:0) after 1m0s
[05:22:33.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:12:0)
[05:22:33.383] Timer tick, asking Buildbucket for the build status
[05:22:33.476] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:33.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:13:0) after 1m0s
[05:23:33.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:13:0)
[05:23:33.633] Timer tick, asking Buildbucket for the build status
[05:23:33.733] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:33.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:14:0) after 1m0s
[05:24:33.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:14:0)
[05:24:33.812] Timer tick, asking Buildbucket for the build status
[05:24:33.879] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:33.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:15:0) after 1m0s
[05:25:33.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:15:0)
[05:25:33.859] Timer tick, asking Buildbucket for the build status
[05:25:33.927] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:33.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:16:0) after 1m0s
[05:26:34.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:16:0)
[05:26:34.086] Timer tick, asking Buildbucket for the build status
[05:26:34.417] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:34.417] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:17:0) after 1m0s
[05:27:34.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:17:0)
[05:27:34.542] Timer tick, asking Buildbucket for the build status
[05:27:34.907] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:34.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:18:0) after 1m0s
[05:28:35.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:18:0)
[05:28:35.022] Timer tick, asking Buildbucket for the build status
[05:28:35.093] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:35.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:19:0) after 1m0s
[05:29:35.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:19:0)
[05:29:35.171] Timer tick, asking Buildbucket for the build status
[05:29:35.234] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:35.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:20:0) after 1m0s
[05:30:35.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:20:0)
[05:30:35.340] Timer tick, asking Buildbucket for the build status
[05:30:35.403] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:35.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:21:0) after 1m0s
[05:31:35.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:21:0)
[05:31:35.454] Timer tick, asking Buildbucket for the build status
[05:31:35.521] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:35.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:22:0) after 1m0s
[05:32:35.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:22:0)
[05:32:35.667] Timer tick, asking Buildbucket for the build status
[05:32:35.857] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:35.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:23:0) after 1m0s
[05:33:35.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:23:0)
[05:33:35.941] Timer tick, asking Buildbucket for the build status
[05:33:36.015] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:36.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:24:0) after 1m0s
[05:34:36.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:24:0)
[05:34:36.191] Timer tick, asking Buildbucket for the build status
[05:34:36.450] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:36.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:25:0) after 1m0s
[05:35:36.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:25:0)
[05:35:36.545] Timer tick, asking Buildbucket for the build status
[05:35:36.652] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:36.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:26:0) after 1m0s
[05:36:36.695] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:26:0)
[05:36:36.695] Timer tick, asking Buildbucket for the build status
[05:36:37.011] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:37.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:27:0) after 1m0s
[05:37:37.081] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:27:0)
[05:37:37.081] Timer tick, asking Buildbucket for the build status
[05:37:37.573] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:37.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:28:0) after 1m0s
[05:38:37.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:28:0)
[05:38:37.693] Timer tick, asking Buildbucket for the build status
[05:38:37.782] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:37.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:29:0) after 1m0s
[05:39:37.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:29:0)
[05:39:37.760] Timer tick, asking Buildbucket for the build status
[05:39:38.199] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:38.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:30:0) after 1m0s
[05:40:38.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:30:0)
[05:40:38.211] Timer tick, asking Buildbucket for the build status
[05:40:38.343] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:38.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:31:0) after 1m0s
[05:41:38.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:31:0)
[05:41:38.379] Timer tick, asking Buildbucket for the build status
[05:41:38.493] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:38.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:32:0) after 1m0s
[05:42:38.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:32:0)
[05:42:38.574] Timer tick, asking Buildbucket for the build status
[05:42:38.675] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:38.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:33:0) after 1m0s
[05:43:38.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:33:0)
[05:43:38.774] Timer tick, asking Buildbucket for the build status
[05:43:38.941] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:38.941] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:34:0) after 1m0s
[05:44:39.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:34:0)
[05:44:39.027] Timer tick, asking Buildbucket for the build status
[05:44:39.152] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:39.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:35:0) after 1m0s
[05:45:39.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:35:0)
[05:45:39.198] Timer tick, asking Buildbucket for the build status
[05:45:39.305] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:39.305] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:36:0) after 1m0s
[05:46:39.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:36:0)
[05:46:39.477] Timer tick, asking Buildbucket for the build status
[05:46:40.262] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:40.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:37:0) after 1m0s
[05:47:40.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:37:0)
[05:47:40.323] Timer tick, asking Buildbucket for the build status
[05:47:40.688] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:40.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:38:0) after 1m0s
[05:48:40.786] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:38:0)
[05:48:40.786] Timer tick, asking Buildbucket for the build status
[05:48:40.981] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:40.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:39:0) after 1m0s
[05:49:41.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:39:0)
[05:49:41.028] Timer tick, asking Buildbucket for the build status
[05:49:41.151] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:41.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:40:0) after 1m0s
[05:50:41.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:40:0)
[05:50:41.270] Timer tick, asking Buildbucket for the build status
[05:50:41.493] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:41.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:41:0) after 1m0s
[05:51:41.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:41:0)
[05:51:41.535] Timer tick, asking Buildbucket for the build status
[05:51:41.639] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:41.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:42:0) after 1m0s
[05:52:41.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:42:0)
[05:52:41.682] Timer tick, asking Buildbucket for the build status
[05:52:41.800] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:41.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:43:0) after 1m0s
[05:53:41.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:43:0)
[05:53:41.808] Timer tick, asking Buildbucket for the build status
[05:53:41.951] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:41.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:44:0) after 1m0s
[05:54:42.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:44:0)
[05:54:42.072] Timer tick, asking Buildbucket for the build status
[05:54:42.267] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:42.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:45:0) after 1m0s
[05:55:42.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:45:0)
[05:55:42.355] Timer tick, asking Buildbucket for the build status
[05:55:42.473] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:42.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:46:0) after 1m0s
[05:56:42.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:46:0)
[05:56:42.514] Timer tick, asking Buildbucket for the build status
[05:56:42.636] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:42.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:47:0) after 1m0s
[05:57:42.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:47:0)
[05:57:42.738] Timer tick, asking Buildbucket for the build status
[05:57:43.122] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:43.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:48:0) after 1m0s
[05:58:43.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:48:0)
[05:58:43.463] Timer tick, asking Buildbucket for the build status
[05:58:43.585] Build 8865766148453343616: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:43.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9031196212354751120:49:0) after 1m0s
[05:59:08.387] Received PubSub notification, asking Buildbucket for the build status
[05:59:09.344] Build 8865766148453343616: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:59:09.344] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1603346346171556",
"created_by": "project:chromium",
"created_ts": "1603343551164641",
"id": "8865766148453343616",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"20a9ff5d0c01f4450a9becf622c6a5802ace6980\"}}",
"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\": \"20a9ff5d0c01f4450a9becf622c6a5802ace6980\", \"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-113-90r6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42164, \"got_angle_revision\": \"6029e464cf9306f110fb40d10467170e87b74a50\", \"got_dawn_revision\": \"22505a5afe1f75b402a00a27d49e313fbd6e2181\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"20a9ff5d0c01f4450a9becf622c6a5802ace6980\", \"got_revision_cp\": \"refs/heads/master@{#819704}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"d9ccb94fc2738d2c7bec626c287518c5e3ad14e9\", \"got_v8_revision_cp\": \"refs/heads/8.8.149@{#1}\", \"got_webrtc_revision\": \"7bc3356fbcb9b95ea2c810ae2f3152930d54577b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32449}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"20a9ff5d0c01f4450a9becf622c6a5802ace6980\", \"swarm_hashes_refs/heads/master(at){#819704}_without_patch\": {\"absl_hardening_tests\": \"f12d0204151d72ce46da2dfc72a9193d1d9e15ca\", \"accessibility_unittests\": \"67fb9b03e2014f095a4b49bdb6189ace08f7da76\", \"app_list_unittests\": \"b35455ae675b4c5d00d8b03c1265ce9b33c06c1d\", \"app_shell_unittests\": \"683f6ce6970a65710da6e8a74bdac3f6a881cc8f\", \"ash_unittests\": \"ff9e0c48ddf4ce2746c0b1796f7040b3876d0dfa\", \"aura_unittests\": \"89ed237f91dd3e66367f8db978f014f4d060bad4\", \"base_unittests\": \"3bb8e20aea6a866e672419d952c8dc9c97821362\", \"base_util_unittests\": \"271e47643f5dec9389701e9c95c6c0b751016086\", \"blink_common_unittests\": \"57b029e317b4b5fdf807ccb8821d80c508eb7a61\", \"blink_fuzzer_unittests\": \"1ffb78eada7e6bad949d6e9ce067f872075795c4\", \"blink_heap_unittests\": \"ee27cd2581b2511f02513763daf4244d57cb0bf5\", \"blink_platform_unittests\": \"b9ec968dc57c5055bf27e1998509aa82405793b5\", \"blink_unittests\": \"cdf51873df9da95afcaeaa72265031adc149052c\", \"boringssl_crypto_tests\": \"1d26953a6be4bcf5a478d4da301b0afbbda65748\", \"boringssl_ssl_tests\": \"c10a072571836e624b8b95187bcd4b63ed48e079\", \"browser_tests\": \"2791489c0d173434c8a841571e6397babe0bfe1e\", \"capture_unittests\": \"ac1560e125a73931ce96bf1b7fdfdf7eeb367d50\", \"cast_unittests\": \"578db7a9a6238bd92a97bdeeb05db9b5f21e4de5\", \"cc_unittests\": \"89cd6b6e57f682e6308dac6e7847269d69c27204\", \"chrome_app_unittests\": \"90289548c54d1347c8af305c5cb49add6973b42f\", \"chromedriver_unittests\": \"d776345777bf722dc37a95f40f53c2d82dcfff98\", \"chromeos_components_unittests\": \"7704dd7551d3759fd064da2325a444c9053d9ad3\", \"chromeos_unittests\": \"66c2b24eb34fb4d7d7bd7abed9676505d9f88f23\", \"components_browsertests\": \"8049e93046e804284694a1ac27603703952353e0\", \"components_unittests\": \"7283f6986e5518fb58cdd6be5f2714163c3f90b7\", \"compositor_unittests\": \"53eb54460c764786ccaf42f93e604c0cbf53c6ab\", \"content_browsertests\": \"35e2509bf08cf34845dcc182beaa8b293dd6eb01\", \"content_unittests\": \"0b4c4e69edfb98e0da9bf05103895e46366ba715\", \"crypto_unittests\": \"d1a538754ab1dbb6c6e268074cc28b40861f9364\", \"dbus_unittests\": \"9c36674b43faead5b8796d2897b2a2dcfb21d36e\", \"device_unittests\": \"7e54a8f8bf9eb41c59483eb0a911300b6ddc5982\", \"display_unittests\": \"6e804a5bda94e4d1e09725805f49d06ed61b2120\", \"events_unittests\": \"74fc17a9d0f98c7ea3441a7909bc92e39780f0e1\", \"exo_unittests\": \"3dd0f77aaec1837297b1ef101404de3f814d5458\", \"extensions_browsertests\": \"7cede2803cad9e347dbc0f8890b4b36fd68b3ca3\", \"extensions_unittests\": \"724674a0bc91b9e5d0cedda8a2b6ba5381de4e0d\", \"filesystem_service_unittests\": \"6f5d46cf05a87a331c7e488432376b3a1fc65f94\", \"gcm_unit_tests\": \"6dd252ab9019ab358d2aa81b92c37335070c0b01\", \"gfx_unittests\": \"1a87666cac2f753082fff26fae03586441d7d5a0\", \"gin_unittests\": \"ddea595161e6e2f150318e40e7a99906beae9a75\", \"gl_unittests_ozone\": \"53d9a570cd82bb9467cc5b88b7ca445fbb8a13ea\", \"google_apis_unittests\": \"599a37273a1c77a3ca33206403daa6aef8d4d3a0\", \"gpu_unittests\": \"a4ed8dec024be1882bdae0b17275a3afe7c00174\", \"gwp_asan_unittests\": \"27493fc566dbcced6527cfaaa6c29849270f4631\", \"interactive_ui_tests\": \"d1b6520e37407ae9192f896bf7af0614ea9a20a4\", \"ipc_tests\": \"370b3a2ba296897c5b600ea1e283f91da99ffa0a\", \"jingle_unittests\": \"cce903135aa476b7561e21f1b2d2bfbbf8dd6608\", \"keyboard_unittests\": \"b73eda64cc052a9b611e4191274504aceee1301b\", \"latency_unittests\": \"95eb6e81eca62c413dfcba79bd2f81bc226ce24f\", \"libjingle_xmpp_unittests\": \"a82688479fb65f016dddf70695c4ab52584f7fb3\", \"media_blink_unittests\": \"7cc705e991dc3c57eb708537d3a9c0b2c6bea0b6\", \"media_unittests\": \"357eced6cfcd3440e5e2f5348de94406aa6ab731\", \"message_center_unittests\": \"4df010fc2259f3e03523434dc9b2f6cf68c695a8\", \"midi_unittests\": \"16acc0b1cfb4936ede4bdb63a91ebf609fdec78f\", \"mojo_core_unittests\": \"7e7afab80faeea8cd191730e12003febc0b40bb0\", \"mojo_unittests\": \"69734d812956b10d4f5cf7d7564ced0f1a6444bc\", \"nacl_helper_nonsfi_unittests\": \"8aaa66cc36f91578b29c823599def6a02d0c732b\", \"nacl_loader_unittests\": \"906a5361293167b8ef99dc7554d99ff40fd43e16\", \"native_theme_unittests\": \"e8eb87bf87c15eedd7ae546fc4cdfe25436baf0f\", \"net_unittests\": \"2af327e1dbcce335098f8ba2acff991cf9e058cf\", \"ozone_gl_unittests\": \"6580d350fc76c457404ce6106b620df9bca709ec\", \"ozone_unittests\": \"6e0cc12247674a0499e55a137fe42c479d0b7b7a\", \"ozone_x11_unittests\": \"b7d2d7d07fd0a523c9ad75d8949090ec463caddb\", \"pdf_unittests\": \"16be0a95babfa8baca50f799f8d03bcbf9c9805e\", \"perfetto_unittests\": \"40bdc9de74a72a40a7c7b6a18f5061f26c2f7706\", \"ppapi_unittests\": \"190c7eece2246559c5b1818723627a7c24c86de1\", \"printing_unittests\": \"4bb48705c44a135628099eaf4163d3eeb82f06c8\", \"remoting_unittests\": \"06d059a8243d13df7fbd212b8ba43a8c08867333\", \"sandbox_linux_unittests\": \"4d5c7f778397d7deee2f0bb737a712c24fb9da31\", \"service_manager_unittests\": \"272d7f4103cb9bafa4b0a5ce15cd83eafa7024bf\", \"services_unittests\": \"363b4d6a07b7f7e31fceab665d5f8ab730aec822\", \"shell_dialogs_unittests\": \"4f791e524850472968f41f10d5d886e023267ae9\", \"skia_unittests\": \"ebe3c2304a858796421fe6c71d2cb043cfdecd7e\", \"snapshot_unittests\": \"0f82cc28cd8c59e0395620c260bccf8214a34079\", \"sql_unittests\": \"085312738e0ddeb29ef7d7c80dbcdb329c785a34\", \"standalone_angle_unittests\": \"b1ce34f729a3eaac19dcef81ea8d55094cc843d0\", \"storage_unittests\": \"b085a409cc5ce74b7ad6832db0cd35d7385539bb\", \"sync_integration_tests\": \"4ba0b669d0fb1ecf103c55270b19daec3fe73847\", \"traffic_annotation_auditor_unittests\": \"9a48f848118f0410fc4ee2391c79b7d385f51ed7\", \"ui_base_unittests\": \"d96fadc209d8870203da9507e123836c2d1ea3d3\", \"ui_chromeos_unittests\": \"695f81018901b3c914eefd36a0c2190909e40126\", \"ui_touch_selection_unittests\": \"a00f2857ddb29dab7b04f5d81a15f3cf38fca939\", \"unit_tests\": \"a7d55aaa00d53c4356be4c3be874c3dda311a1e0\", \"url_unittests\": \"b24cd5c550de21d773231444c7a2b443d3191479\", \"usage_time_limit_unittests\": \"083378ef90959af4b860cd10f4cac6fbd591cc26\", \"views_unittests\": \"5204034dbd1853d7864061de0d41a34c0c46c9e9\", \"viz_unittests\": \"35708d61bcbfa87725e5f75e6d937bd5ce7d55cf\", \"wayland_client_perftests\": \"30e01978c7b89160ccc952adae7b381d4b533aef\", \"wm_unittests\": \"3db5b331388d2d35c1d0a1eab49d882e8fc552b3\", \"wtf_unittests\": \"c6155312ec889c3efed048b683cfb5b161c6498a\", \"zlib_unittests\": \"4b783c4f76ac946449bc84ffbadc8b038ea44ffe\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_6ee12f05c9a2b0c9a3d47d2261f6d29ee6e08ee8be34f06fc5e9b02ed5b85324_v2\", \"builder_73a5b2ce307b316a1240917eaad41a92e4adc44903c6789e05a5f10300306cda_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_953e900270162ec95f568ea264af47d43b9a29a15e01ede040ffa4d15b188919_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_b571a4badcb43acd83695cf3dbb5d1bfee45911d6db61e100dcde651b2bf5c98_v2\", \"builder_c960022844155a7f8e715442a6b4552ebbee25f8ba7e1f4575586223f821653a_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-113-90r6\"], \"image\": [\"chrome-xenial-20101600-2d400e1627f\"], \"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\": [\"5601-97d7e7d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603343552686662",
"status": "COMPLETED",
"status_changed_ts": "1603346346930600",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42164",
"builder:linux-chromeos-rel",
"buildset:commit/git/20a9ff5d0c01f4450a9becf622c6a5802ace6980",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/20a9ff5d0c01f4450a9becf622c6a5802ace6980",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031196212354751120",
"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/8865766148453343616/+/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:4f678a94d8dde010",
"user_agent:luci-scheduler"
],
"updated_ts": "1603346346990781",
"url": "https://ci.chromium.org/b/8865766148453343616",
"utcnow_ts": "1603346349334438"
}
}
[05:59:09.344] Invocation finished in 46m41.284728482s with status SUCCEEDED