[16:37:40.418] New invocation is queued and will start shortly
[16:37:41.566] Starting the invocation (attempt 1)
[16:37:41.607] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:37:41.607] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:37:41.607] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030247133275982096",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"af6207c5d56f6c4bb23bc5c060e415931aa516d2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9030247133275982096",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/af6207c5d56f6c4bb23bc5c060e415931aa516d2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/af6207c5d56f6c4bb23bc5c060e415931aa516d2",
"gitiles_ref:refs/heads/master"
]
}
[16:37:42.213] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604248661694379",
"id": "8864817071273676352",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"af6207c5d56f6c4bb23bc5c060e415931aa516d2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604248662102565",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42464",
"builder:linux-chromeos-rel",
"buildset:commit/git/af6207c5d56f6c4bb23bc5c060e415931aa516d2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/af6207c5d56f6c4bb23bc5c060e415931aa516d2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030247133275982096",
"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/8864817071273676352/+/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": "1604248662102756",
"url": "https://ci.chromium.org/b/8864817071273676352",
"utcnow_ts": "1604248662204546"
}
}
[16:37:42.213] Task URL: https://ci.chromium.org/b/8864817071273676352
[16:37:42.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:2:0) after 1m0s
[16:38:42.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:2:0)
[16:38:42.236] Timer tick, asking Buildbucket for the build status
[16:38:42.404] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:38:42.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:3:0) after 1m0s
[16:39:42.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:3:0)
[16:39:42.556] Timer tick, asking Buildbucket for the build status
[16:39:42.730] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:39:42.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:4:0) after 1m0s
[16:40:42.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:4:0)
[16:40:42.750] Timer tick, asking Buildbucket for the build status
[16:40:42.832] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:40:42.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:5:0) after 1m0s
[16:41:42.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:5:0)
[16:41:42.909] Timer tick, asking Buildbucket for the build status
[16:41:43.228] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:41:43.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:6:0) after 1m0s
[16:42:43.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:6:0)
[16:42:43.312] Timer tick, asking Buildbucket for the build status
[16:42:43.416] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:42:43.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:7:0) after 1m0s
[16:43:43.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:7:0)
[16:43:43.441] Timer tick, asking Buildbucket for the build status
[16:43:43.544] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:43:43.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:8:0) after 1m0s
[16:44:43.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:8:0)
[16:44:43.617] Timer tick, asking Buildbucket for the build status
[16:44:43.703] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:44:43.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:9:0) after 1m0s
[16:45:43.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:9:0)
[16:45:43.745] Timer tick, asking Buildbucket for the build status
[16:45:43.820] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:45:43.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:10:0) after 1m0s
[16:46:43.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:10:0)
[16:46:43.921] Timer tick, asking Buildbucket for the build status
[16:46:44.006] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:46:44.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:11:0) after 1m0s
[16:47:44.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:11:0)
[16:47:44.043] Timer tick, asking Buildbucket for the build status
[16:47:44.148] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:47:44.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:12:0) after 1m0s
[16:48:44.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:12:0)
[16:48:44.230] Timer tick, asking Buildbucket for the build status
[16:48:45.005] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:48:45.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:13:0) after 1m0s
[16:49:45.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:13:0)
[16:49:45.027] Timer tick, asking Buildbucket for the build status
[16:49:45.114] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:49:45.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:14:0) after 1m0s
[16:50:45.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:14:0)
[16:50:45.135] Timer tick, asking Buildbucket for the build status
[16:50:45.579] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:50:45.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:15:0) after 1m0s
[16:51:45.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:15:0)
[16:51:45.647] Timer tick, asking Buildbucket for the build status
[16:51:46.066] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:51:46.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:16:0) after 1m0s
[16:52:46.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:16:0)
[16:52:46.114] Timer tick, asking Buildbucket for the build status
[16:52:46.209] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:52:46.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:17:0) after 1m0s
[16:53:46.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:17:0)
[16:53:46.243] Timer tick, asking Buildbucket for the build status
[16:53:48.178] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:53:48.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:18:0) after 1m0s
[16:54:48.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:18:0)
[16:54:48.228] Timer tick, asking Buildbucket for the build status
[16:54:48.294] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:54:48.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:19:0) after 1m0s
[16:55:48.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:19:0)
[16:55:48.318] Timer tick, asking Buildbucket for the build status
[16:55:48.425] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:55:48.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:20:0) after 1m0s
[16:56:48.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:20:0)
[16:56:48.445] Timer tick, asking Buildbucket for the build status
[16:56:48.543] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:56:48.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:21:0) after 1m0s
[16:57:48.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:21:0)
[16:57:48.561] Timer tick, asking Buildbucket for the build status
[16:57:48.811] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:57:48.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:22:0) after 1m0s
[16:58:48.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:22:0)
[16:58:48.832] Timer tick, asking Buildbucket for the build status
[16:58:48.910] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:58:48.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:23:0) after 1m0s
[16:59:48.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:23:0)
[16:59:48.935] Timer tick, asking Buildbucket for the build status
[16:59:49.078] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[16:59:49.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:24:0) after 1m0s
[17:00:49.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:24:0)
[17:00:49.119] Timer tick, asking Buildbucket for the build status
[17:00:49.287] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:00:49.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:25:0) after 1m0s
[17:01:49.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:25:0)
[17:01:49.327] Timer tick, asking Buildbucket for the build status
[17:01:49.416] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:01:49.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:26:0) after 1m0s
[17:02:49.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:26:0)
[17:02:49.449] Timer tick, asking Buildbucket for the build status
[17:02:49.543] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:02:49.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:27:0) after 1m0s
[17:03:49.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:27:0)
[17:03:49.562] Timer tick, asking Buildbucket for the build status
[17:03:49.631] Build 8864817071273676352: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:03:49.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:28:0) after 1m0s
[17:04:10.151] Received PubSub notification, asking Buildbucket for the build status
[17:04:10.221] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:49.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:28:0)
[17:04:49.664] Timer tick, asking Buildbucket for the build status
[17:04:49.762] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:49.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:30:0) after 1m0s
[17:05:49.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:30:0)
[17:05:49.794] Timer tick, asking Buildbucket for the build status
[17:05:49.889] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:49.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:31:0) after 1m0s
[17:06:49.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:31:0)
[17:06:49.911] Timer tick, asking Buildbucket for the build status
[17:06:50.112] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:50.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:32:0) after 1m0s
[17:07:50.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:32:0)
[17:07:50.186] Timer tick, asking Buildbucket for the build status
[17:07:50.690] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:50.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:33:0) after 1m0s
[17:08:50.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:33:0)
[17:08:50.777] Timer tick, asking Buildbucket for the build status
[17:08:50.911] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:50.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:34:0) after 1m0s
[17:09:50.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:34:0)
[17:09:50.958] Timer tick, asking Buildbucket for the build status
[17:09:51.068] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:51.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:35:0) after 1m0s
[17:10:51.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:35:0)
[17:10:51.110] Timer tick, asking Buildbucket for the build status
[17:10:51.312] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:51.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:36:0) after 1m0s
[17:11:51.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:36:0)
[17:11:51.385] Timer tick, asking Buildbucket for the build status
[17:11:51.526] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:51.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:37:0) after 1m0s
[17:12:51.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:37:0)
[17:12:51.657] Timer tick, asking Buildbucket for the build status
[17:12:51.808] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:51.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:38:0) after 1m0s
[17:13:51.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:38:0)
[17:13:51.900] Timer tick, asking Buildbucket for the build status
[17:13:51.978] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:51.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:39:0) after 1m0s
[17:14:51.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:39:0)
[17:14:51.998] Timer tick, asking Buildbucket for the build status
[17:14:52.083] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:52.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:40:0) after 1m0s
[17:15:52.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:40:0)
[17:15:52.111] Timer tick, asking Buildbucket for the build status
[17:15:52.284] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:52.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:41:0) after 1m0s
[17:16:52.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:41:0)
[17:16:52.288] Timer tick, asking Buildbucket for the build status
[17:16:52.430] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:52.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:42:0) after 1m0s
[17:17:52.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:42:0)
[17:17:52.469] Timer tick, asking Buildbucket for the build status
[17:17:53.057] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:53.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:43:0) after 1m0s
[17:18:53.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:43:0)
[17:18:53.104] Timer tick, asking Buildbucket for the build status
[17:18:53.200] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:53.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:44:0) after 1m0s
[17:19:53.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:44:0)
[17:19:53.226] Timer tick, asking Buildbucket for the build status
[17:19:53.486] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:53.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:45:0) after 1m0s
[17:20:53.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:45:0)
[17:20:53.508] Timer tick, asking Buildbucket for the build status
[17:20:53.622] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:53.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:46:0) after 1m0s
[17:21:53.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:46:0)
[17:21:53.735] Timer tick, asking Buildbucket for the build status
[17:21:53.839] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:53.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:47:0) after 1m0s
[17:22:53.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:47:0)
[17:22:53.876] Timer tick, asking Buildbucket for the build status
[17:22:54.010] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:54.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:48:0) after 1m0s
[17:23:54.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:48:0)
[17:23:54.043] Timer tick, asking Buildbucket for the build status
[17:23:54.154] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:54.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:49:0) after 1m0s
[17:24:54.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:49:0)
[17:24:54.164] Timer tick, asking Buildbucket for the build status
[17:24:54.273] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:54.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:50:0) after 1m0s
[17:25:54.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:50:0)
[17:25:54.379] Timer tick, asking Buildbucket for the build status
[17:25:54.527] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:54.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:51:0) after 1m0s
[17:26:54.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:51:0)
[17:26:54.603] Timer tick, asking Buildbucket for the build status
[17:26:54.737] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:54.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:52:0) after 1m0s
[17:27:54.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:52:0)
[17:27:54.804] Timer tick, asking Buildbucket for the build status
[17:27:54.924] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:54.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:53:0) after 1m0s
[17:28:54.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:53:0)
[17:28:54.963] Timer tick, asking Buildbucket for the build status
[17:28:55.093] Build 8864817071273676352: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:55.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030247133275982096:54:0) after 1m0s
[17:29:30.243] Received PubSub notification, asking Buildbucket for the build status
[17:29:30.314] Build 8864817071273676352: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:29:30.314] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604251769258246",
"created_by": "project:chromium",
"created_ts": "1604248661694379",
"id": "8864817071273676352",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"af6207c5d56f6c4bb23bc5c060e415931aa516d2\"}}",
"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\": \"af6207c5d56f6c4bb23bc5c060e415931aa516d2\", \"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-19-82ci\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42464, \"got_angle_revision\": \"9c66a0925dbc6c03f898a852702d504fd465c133\", \"got_dawn_revision\": \"0a374dce665328391ab3b68fd9e667b018dd9dcd\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"af6207c5d56f6c4bb23bc5c060e415931aa516d2\", \"got_revision_cp\": \"refs/heads/master@{#823021}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e0de282e678b72dac25b81f8d25305231aec01f8\", \"got_v8_revision\": \"69c856dc816ff1dd65fcc536095b44399a7434b9\", \"got_v8_revision_cp\": \"refs/heads/8.8.214@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"af6207c5d56f6c4bb23bc5c060e415931aa516d2\", \"swarm_hashes_refs/heads/master(at){#823021}_without_patch\": {\"absl_hardening_tests\": \"94032ad96ee841b5ba3448b799c19b55cdd409f6\", \"accessibility_unittests\": \"48989efae452bebff5e2ef0db4d659ebcb13bdaf\", \"angle_unittests\": \"c722937502acf0bbac996f415cd6829f863841e4\", \"app_list_unittests\": \"f0d7e39bcd9e7faebbe290b9e484c6861fb54dec\", \"app_shell_unittests\": \"17e286f724730b0489803a6b4e09900ee87a9f34\", \"ash_unittests\": \"0cf8a30bf304ab1bb5324d43f66d185dceca33ce\", \"aura_unittests\": \"3f97edf87a54cb1be6aeea44ff08b0690cc90c4d\", \"base_unittests\": \"a5d94941e3c3a0f50b57e089e54c586902844fe6\", \"base_util_unittests\": \"3d05ef2082b2ae682a0caf9d51c391f8b3ab79d3\", \"blink_common_unittests\": \"613d534fb79d963323d7769460b3a0b6355c5c23\", \"blink_fuzzer_unittests\": \"ea406a810231aa42c397219e669402fe00a2d9de\", \"blink_heap_unittests\": \"c3d9f72757dd6696661ed69c49e5b69eef423e73\", \"blink_platform_unittests\": \"63dd865a0f191fb81092cc87e675ec2af723d246\", \"blink_unittests\": \"655b002b0ece2bd37ac27d1f8ba05ee88ae2f3b1\", \"boringssl_crypto_tests\": \"f56b7a4f29864c8b63ff6161ea8c1064bd0570af\", \"boringssl_ssl_tests\": \"41ab5a350ca270f1b14fd6c342289c25a8007d8b\", \"browser_tests\": \"c1f7bb3a09c794bba6559d7fa201c21a7f930d09\", \"capture_unittests\": \"b568bec31124154ec90a43c8ad5649ed5e27b9c2\", \"cast_unittests\": \"95aa57e5a8be1c7ef492bf573ad0ec0e6038d486\", \"cc_unittests\": \"35aeaef7aebc822a00c4f84cc998e62e3ff2e740\", \"chrome_app_unittests\": \"8dd53ae9b1261e7a6f685dbaef4566b87a547f72\", \"chromedriver_unittests\": \"a73d230352448d69687cb87021270811ebaafeba\", \"chromeos_components_unittests\": \"4e079e8f61e734a4bc675236857a3650e82e1993\", \"chromeos_unittests\": \"b719ae296f0ece14b41e828feee1bd7436c61508\", \"components_browsertests\": \"b6bffaf497b1b9da745db278657e6ba61dbd6462\", \"components_unittests\": \"a870d17cd4a4b7da363c03051a1482296d995d67\", \"compositor_unittests\": \"7bed183e3ece122dd582b0770a006d96dc4591a6\", \"content_browsertests\": \"7d14103b8f96941c816a94c77da5e150bf2563ff\", \"content_unittests\": \"76c7b33f724e36b94d9ac3bf82577321dc6f8969\", \"crypto_unittests\": \"a275f2c1734cf538f979a68c592b5f6e7b06d617\", \"dbus_unittests\": \"215452eb62df0f8253536f6bddd5e58f28cbf32d\", \"device_unittests\": \"e70cea6383102932c9c0374a56c8b20f9e432bb8\", \"display_unittests\": \"89176562e6ad8918ded7019c3406a6f0e6ba87f7\", \"events_unittests\": \"d91eb404fd8d73f813e48b7f0cc2cfee2214986f\", \"exo_unittests\": \"b4f6f3a2cfd47c218dc95700822e34c6ae016439\", \"extensions_browsertests\": \"de77f6288a9d0274e825d38201a65bfbfbea2e3e\", \"extensions_unittests\": \"dc1c3ebf8f7224558401ff197e38077c50fd3971\", \"filesystem_service_unittests\": \"9820fe3b986e3a8ee13220b63260b0b6595c101b\", \"gcm_unit_tests\": \"0815c51fe8e071405b7aecd605bcac2059c32541\", \"gfx_unittests\": \"8109a4351dadff0a65f88007077fa4818cdfe33c\", \"gin_unittests\": \"463c241aeec583aab7bb2746d79d4a8697439c8a\", \"gl_unittests_ozone\": \"99fedcfb3d80421865299174f6b1e4e5e473ab1f\", \"google_apis_unittests\": \"9105e69927bca2852de61f3beb734242377bbe03\", \"gpu_unittests\": \"8a8ddcc74638e4e012b325bcbaa5e7220b560e04\", \"gwp_asan_unittests\": \"0f711f2ace61882bc76efacccb22b62df9cd152e\", \"interactive_ui_tests\": \"c76077997a64703ad3d423104634bdc39972a638\", \"ipc_tests\": \"0f27303bb8f9d7d6fe3196235447f5364ba3b3b7\", \"jingle_unittests\": \"6eebe90a18f95ad1ce17f420358f6129911b742f\", \"keyboard_unittests\": \"0f62c4454e868ef73fddc806e18bb0be6561dbd2\", \"latency_unittests\": \"f9c710d2345088a8ef48c5f01f6a33567194f406\", \"libjingle_xmpp_unittests\": \"626119dfb905ed0644806731e597987cafeee881\", \"liburlpattern_unittests\": \"e8740c4d986c7c335646e76578663bb54e9059dc\", \"media_blink_unittests\": \"d78be94cf1c8ac5cd5cfacf2b406a30df37eaec1\", \"media_unittests\": \"75f4e8a1a29471f20021abb814f04475e9382a36\", \"message_center_unittests\": \"8a131ec99b2d62f88ac700597b33bbc5229d6e5d\", \"midi_unittests\": \"7d69d7abc3f04654664f73f1f0d4c39baee7ecd1\", \"mojo_core_unittests\": \"8b1ed06f79ab8fbe7c61515d69560450b5f14f33\", \"mojo_unittests\": \"96057881f2df22109a35f1444fbb6eb53ffbbf61\", \"nacl_helper_nonsfi_unittests\": \"8767c0a462922d842e7b987978467f21c6cbd1af\", \"nacl_loader_unittests\": \"8f9bf3d952f69d16e04a3c450693c7e7ac23321b\", \"native_theme_unittests\": \"118e59e0d5c5802cfadafea94b99cbd0c4b6f703\", \"net_unittests\": \"47ed7c6f599f738d6838abb75ab8feac896010ad\", \"ozone_gl_unittests\": \"623d16ceada2e362f3db3847d24ee7ef6d0e1f5a\", \"ozone_unittests\": \"5fb1fe22a04ff4a15934cb11fcca5d6538a2c5b8\", \"ozone_x11_unittests\": \"3b0155f5f6b476ff2ad5581288479f83fec35ee9\", \"pdf_unittests\": \"c72c8acbdba413014a81a94170594a0f5bdcce7b\", \"perfetto_unittests\": \"dae1418a11f940c08aac8e760ed0d9f696953bf2\", \"ppapi_unittests\": \"63224da0f741b466b9739ed8925155c91e225d96\", \"printing_unittests\": \"68efd6fc1f0b91215b1aaf00f7aae9f94203f2e5\", \"remoting_unittests\": \"7575c120179b6d7bb0ed69a4aafaab4e07b4e781\", \"sandbox_linux_unittests\": \"2be99528eefbf2dcdc33bfe2ffc47ae8f5eff613\", \"service_manager_unittests\": \"3af87d06139c2a8512310d3472e135d75139accc\", \"services_unittests\": \"4a2409794da741d741c6455afb12a5bc09ba2edd\", \"shell_dialogs_unittests\": \"6c45ea41cedad59f8c0fa39ad2b6b2626d7c31cc\", \"skia_unittests\": \"28be489f28e61614d060809ead515f8173e31a79\", \"snapshot_unittests\": \"69055e807e595f43f64c88085577c943e7f51efb\", \"sql_unittests\": \"354a0db61f1c74628a5433bc0a533843eb480ac1\", \"storage_unittests\": \"ff0e9376d66efacc1734907653a794bce1b7f1c4\", \"sync_integration_tests\": \"876c6ea8815164eee2759174efde1dc6af8712c9\", \"traffic_annotation_auditor_unittests\": \"243355bfc0e3b7d38fab9a39a7570cb3903df961\", \"ui_base_unittests\": \"5e3715cb2849379881edb6137f859af13176a603\", \"ui_chromeos_unittests\": \"bb046ca76327576b1d72c26816b01da3324379e6\", \"ui_touch_selection_unittests\": \"825e86762257490ffb4a535961c27150a4430129\", \"unit_tests\": \"68d41d6b558536ef39ef594a7c5a0ab3c31e5bd1\", \"url_unittests\": \"6b8f8b1a88e8f79d4ecef89fd6ba9d8df6a54676\", \"usage_time_limit_unittests\": \"30ed55546fae66f800ca969eda807b6d068c1d6d\", \"views_unittests\": \"e7a56be3ad7f433dae63bc2d8ff512391f6df1b2\", \"viz_unittests\": \"52fcf4473a6c5951aaf2fc8ca9ee7cf0ecc8b83a\", \"wayland_client_perftests\": \"c093bd083a995809970faeb32ba6666fe37e88ec\", \"wm_unittests\": \"a2be30764073c434b88868058efa020e0a03377c\", \"wtf_unittests\": \"3b136ecd312ddfff1cb8579ac6826144974810cc\", \"zlib_unittests\": \"f8a7f0f9b2e3ffd3365605523bb2d42bce5c97e5\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_510bb217f1fbd7cfc6f82b4f5538258f70582616cab4052bd10c7cd8994fe33a_v2\", \"builder_642e8105f745eb1a71ee53fae678c471391c0152dcfea24d527182ac47960a08_v2\", \"builder_8e7ad9a10a7772feba5b42dda56992e918fe88f23579c3ddaf696dde66ee4238_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_a432d290b72bc0f3cae401fbd647c33c14340f64e89770e9c9c39d6230495526_v2\", \"builder_c33cb68a27562f3c0030aeadb8872bc9395ca543fdfb70fdbe284a5ae715c202_v2\", \"builder_de45c485d8a81e16b8ff53eb76d94467eed5e11e118465311a13e72e2b141cb1_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-19-82ci\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604250249253355",
"status": "COMPLETED",
"status_changed_ts": "1604251769598092",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42464",
"builder:linux-chromeos-rel",
"buildset:commit/git/af6207c5d56f6c4bb23bc5c060e415931aa516d2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/af6207c5d56f6c4bb23bc5c060e415931aa516d2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030247133275982096",
"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/8864817071273676352/+/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:4f9d7d79f3bd8a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1604251769602881",
"url": "https://ci.chromium.org/b/8864817071273676352",
"utcnow_ts": "1604251770306629"
}
}
[17:29:30.314] Invocation finished in 51m49.913182521s with status SUCCEEDED