[04:06:28.690] New invocation is queued and will start shortly
[04:06:29.826] Starting the invocation (attempt 1)
[04:06:29.860] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:06:29.860] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:06:29.860] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9025764546088453120",
"parameters_json": "{\"builder_name\":\"android-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"fc46ab79e387af75d5b535da5c92ce03340cc9da\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-official",
"scheduler_invocation_id:9025764546088453120",
"scheduler_job_id:chromium/android-official",
"user_agent:luci-scheduler",
"buildset:commit/git/fc46ab79e387af75d5b535da5c92ce03340cc9da",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fc46ab79e387af75d5b535da5c92ce03340cc9da",
"gitiles_ref:refs/heads/master"
]
}
[04:06:30.581] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1608523589945329",
"id": "8860334484108547744",
"parameters_json": "{\"builder_name\": \"android-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fc46ab79e387af75d5b535da5c92ce03340cc9da\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1608523590364038",
"tags": [
"build_address:luci.chromium.ci/android-official/3298",
"builder:android-official",
"buildset:commit/git/fc46ab79e387af75d5b535da5c92ce03340cc9da",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fc46ab79e387af75d5b535da5c92ce03340cc9da",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025764546088453120",
"scheduler_job_id:chromium/android-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8860334484108547744/+/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": "1608523590364158",
"url": "https://ci.chromium.org/b/8860334484108547744",
"utcnow_ts": "1608523590568052"
}
}
[04:06:30.581] Task URL: https://ci.chromium.org/b/8860334484108547744
[04:06:30.581] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:2:0) after 1m0s
[04:06:33.235] Received PubSub notification, asking Buildbucket for the build status
[04:06:33.305] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:30.600] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:2:0)
[04:07:30.600] Timer tick, asking Buildbucket for the build status
[04:07:30.733] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:30.733] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:4:0) after 1m0s
[04:08:30.786] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:4:0)
[04:08:30.786] Timer tick, asking Buildbucket for the build status
[04:08:30.849] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:30.849] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:5:0) after 1m0s
[04:09:30.865] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:5:0)
[04:09:30.865] Timer tick, asking Buildbucket for the build status
[04:09:31.481] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:31.481] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:6:0) after 1m0s
[04:10:31.504] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:6:0)
[04:10:31.505] Timer tick, asking Buildbucket for the build status
[04:10:31.639] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:31.639] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:7:0) after 1m0s
[04:11:31.663] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:7:0)
[04:11:31.663] Timer tick, asking Buildbucket for the build status
[04:11:31.806] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:31.806] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:8:0) after 1m0s
[04:12:31.831] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:8:0)
[04:12:31.831] Timer tick, asking Buildbucket for the build status
[04:12:32.215] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:32.215] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:9:0) after 1m0s
[04:13:32.234] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:9:0)
[04:13:32.234] Timer tick, asking Buildbucket for the build status
[04:13:32.946] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:32.946] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:10:0) after 1m0s
[04:14:33.017] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:10:0)
[04:14:33.017] Timer tick, asking Buildbucket for the build status
[04:14:33.075] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:33.075] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:11:0) after 1m0s
[04:15:33.130] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:11:0)
[04:15:33.130] Timer tick, asking Buildbucket for the build status
[04:15:33.189] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:33.189] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:12:0) after 1m0s
[04:16:33.211] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:12:0)
[04:16:33.211] Timer tick, asking Buildbucket for the build status
[04:16:33.304] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:33.304] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:13:0) after 1m0s
[04:17:33.346] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:13:0)
[04:17:33.346] Timer tick, asking Buildbucket for the build status
[04:17:33.621] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:33.621] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:14:0) after 1m0s
[04:18:33.661] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:14:0)
[04:18:33.661] Timer tick, asking Buildbucket for the build status
[04:18:33.778] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:33.778] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:15:0) after 1m0s
[04:19:33.827] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:15:0)
[04:19:33.827] Timer tick, asking Buildbucket for the build status
[04:19:33.899] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:33.899] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:16:0) after 1m0s
[04:20:33.918] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:16:0)
[04:20:33.918] Timer tick, asking Buildbucket for the build status
[04:20:33.982] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:33.982] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:17:0) after 1m0s
[04:21:34.053] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:17:0)
[04:21:34.053] Timer tick, asking Buildbucket for the build status
[04:21:34.152] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:34.152] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:18:0) after 1m0s
[04:22:34.248] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:18:0)
[04:22:34.248] Timer tick, asking Buildbucket for the build status
[04:22:34.306] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:34.306] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:19:0) after 1m0s
[04:23:34.304] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:19:0)
[04:23:34.304] Timer tick, asking Buildbucket for the build status
[04:23:34.368] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:34.368] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:20:0) after 1m0s
[04:24:34.397] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:20:0)
[04:24:34.397] Timer tick, asking Buildbucket for the build status
[04:24:34.571] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:34.571] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:21:0) after 1m0s
[04:25:34.632] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:21:0)
[04:25:34.632] Timer tick, asking Buildbucket for the build status
[04:25:34.730] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:34.730] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:22:0) after 1m0s
[04:26:34.799] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:22:0)
[04:26:34.799] Timer tick, asking Buildbucket for the build status
[04:26:34.883] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:34.883] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:23:0) after 1m0s
[04:27:34.965] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:23:0)
[04:27:34.965] Timer tick, asking Buildbucket for the build status
[04:27:35.059] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:35.059] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:24:0) after 1m0s
[04:28:35.098] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:24:0)
[04:28:35.098] Timer tick, asking Buildbucket for the build status
[04:28:35.163] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:35.163] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:25:0) after 1m0s
[04:29:35.192] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:25:0)
[04:29:35.192] Timer tick, asking Buildbucket for the build status
[04:29:35.325] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:35.325] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:26:0) after 1m0s
[04:30:35.297] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:26:0)
[04:30:35.298] Timer tick, asking Buildbucket for the build status
[04:30:35.357] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:35.357] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:27:0) after 1m0s
[04:31:35.375] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:27:0)
[04:31:35.375] Timer tick, asking Buildbucket for the build status
[04:31:35.507] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:35.507] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:28:0) after 1m0s
[04:32:35.527] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:28:0)
[04:32:35.527] Timer tick, asking Buildbucket for the build status
[04:32:35.901] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:35.901] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:29:0) after 1m0s
[04:33:35.950] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:29:0)
[04:33:35.950] Timer tick, asking Buildbucket for the build status
[04:33:36.125] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:36.125] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:30:0) after 1m0s
[04:34:36.149] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:30:0)
[04:34:36.149] Timer tick, asking Buildbucket for the build status
[04:34:36.347] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:36.347] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:31:0) after 1m0s
[04:35:36.366] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:31:0)
[04:35:36.366] Timer tick, asking Buildbucket for the build status
[04:35:36.433] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:36.433] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:32:0) after 1m0s
[04:36:36.455] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:32:0)
[04:36:36.455] Timer tick, asking Buildbucket for the build status
[04:36:36.631] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:36.631] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:33:0) after 1m0s
[04:37:36.651] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:33:0)
[04:37:36.651] Timer tick, asking Buildbucket for the build status
[04:37:36.954] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:36.954] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:34:0) after 1m0s
[04:38:36.944] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:34:0)
[04:38:36.944] Timer tick, asking Buildbucket for the build status
[04:38:37.193] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:37.193] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:35:0) after 1m0s
[04:39:37.220] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:35:0)
[04:39:37.220] Timer tick, asking Buildbucket for the build status
[04:39:37.305] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:37.305] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:36:0) after 1m0s
[04:40:37.363] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:36:0)
[04:40:37.363] Timer tick, asking Buildbucket for the build status
[04:40:37.422] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:37.422] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:37:0) after 1m0s
[04:41:37.453] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:37:0)
[04:41:37.453] Timer tick, asking Buildbucket for the build status
[04:41:37.622] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:37.622] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:38:0) after 1m0s
[04:42:37.641] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:38:0)
[04:42:37.641] Timer tick, asking Buildbucket for the build status
[04:42:37.698] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:37.698] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:39:0) after 1m0s
[04:43:37.724] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:39:0)
[04:43:37.724] Timer tick, asking Buildbucket for the build status
[04:43:37.791] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:37.792] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:40:0) after 1m0s
[04:44:37.815] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:40:0)
[04:44:37.815] Timer tick, asking Buildbucket for the build status
[04:44:37.937] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:37.937] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:41:0) after 1m0s
[04:45:37.964] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:41:0)
[04:45:37.964] Timer tick, asking Buildbucket for the build status
[04:45:38.118] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:38.119] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:42:0) after 1m0s
[04:46:38.146] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:42:0)
[04:46:38.146] Timer tick, asking Buildbucket for the build status
[04:46:38.281] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:38.281] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:43:0) after 1m0s
[04:47:38.300] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:43:0)
[04:47:38.300] Timer tick, asking Buildbucket for the build status
[04:47:38.379] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:38.379] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:44:0) after 1m0s
[04:48:38.401] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:44:0)
[04:48:38.401] Timer tick, asking Buildbucket for the build status
[04:48:38.474] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:38.474] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:45:0) after 1m0s
[04:49:38.502] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:45:0)
[04:49:38.502] Timer tick, asking Buildbucket for the build status
[04:49:38.567] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:38.567] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:46:0) after 1m0s
[04:50:38.616] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:46:0)
[04:50:38.616] Timer tick, asking Buildbucket for the build status
[04:50:38.687] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:38.687] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:47:0) after 1m0s
[04:51:38.741] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:47:0)
[04:51:38.741] Timer tick, asking Buildbucket for the build status
[04:51:38.873] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:38.873] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:48:0) after 1m0s
[04:52:38.902] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:48:0)
[04:52:38.902] Timer tick, asking Buildbucket for the build status
[04:52:39.221] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:39.222] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:49:0) after 1m0s
[04:53:39.242] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:49:0)
[04:53:39.242] Timer tick, asking Buildbucket for the build status
[04:53:39.293] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:39.293] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:50:0) after 1m0s
[04:54:39.369] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:50:0)
[04:54:39.369] Timer tick, asking Buildbucket for the build status
[04:54:39.427] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:39.427] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:51:0) after 1m0s
[04:55:39.450] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:51:0)
[04:55:39.450] Timer tick, asking Buildbucket for the build status
[04:55:39.534] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:39.534] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:52:0) after 1m0s
[04:56:39.614] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:52:0)
[04:56:39.614] Timer tick, asking Buildbucket for the build status
[04:56:39.863] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:39.863] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:53:0) after 1m0s
[04:57:39.908] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:53:0)
[04:57:39.908] Timer tick, asking Buildbucket for the build status
[04:57:39.983] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:39.983] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:54:0) after 1m0s
[04:58:40.070] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:54:0)
[04:58:40.070] Timer tick, asking Buildbucket for the build status
[04:58:40.457] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:40.457] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:55:0) after 1m0s
[04:59:40.539] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:55:0)
[04:59:40.539] Timer tick, asking Buildbucket for the build status
[04:59:40.627] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:40.627] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:56:0) after 1m0s
[05:00:40.712] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:56:0)
[05:00:40.712] Timer tick, asking Buildbucket for the build status
[05:00:40.972] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:40.972] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:57:0) after 1m0s
[05:01:42.132] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:57:0)
[05:01:42.132] Timer tick, asking Buildbucket for the build status
[05:01:42.286] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:42.286] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:58:0) after 1m0s
[05:02:42.312] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:58:0)
[05:02:42.312] Timer tick, asking Buildbucket for the build status
[05:02:42.460] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:42.460] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:59:0) after 1m0s
[05:03:42.482] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:59:0)
[05:03:42.482] Timer tick, asking Buildbucket for the build status
[05:03:42.573] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:42.573] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:60:0) after 1m0s
[05:04:42.598] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:60:0)
[05:04:42.598] Timer tick, asking Buildbucket for the build status
[05:04:42.653] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:42.653] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:61:0) after 1m0s
[05:05:42.679] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:61:0)
[05:05:42.679] Timer tick, asking Buildbucket for the build status
[05:05:42.820] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:42.820] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:62:0) after 1m0s
[05:06:42.843] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:62:0)
[05:06:42.843] Timer tick, asking Buildbucket for the build status
[05:06:42.969] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:42.969] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:63:0) after 1m0s
[05:07:42.998] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:63:0)
[05:07:42.998] Timer tick, asking Buildbucket for the build status
[05:07:43.191] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:43.191] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:64:0) after 1m0s
[05:08:43.241] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:64:0)
[05:08:43.241] Timer tick, asking Buildbucket for the build status
[05:08:43.313] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:43.313] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:65:0) after 1m0s
[05:09:43.424] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:65:0)
[05:09:43.424] Timer tick, asking Buildbucket for the build status
[05:09:44.045] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:44.045] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:66:0) after 1m0s
[05:10:44.065] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:66:0)
[05:10:44.065] Timer tick, asking Buildbucket for the build status
[05:10:44.127] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:44.127] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:67:0) after 1m0s
[05:11:44.309] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:67:0)
[05:11:44.309] Timer tick, asking Buildbucket for the build status
[05:11:44.425] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:44.425] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:68:0) after 1m0s
[05:12:44.479] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:68:0)
[05:12:44.479] Timer tick, asking Buildbucket for the build status
[05:12:44.539] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:44.539] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:69:0) after 1m0s
[05:13:44.628] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:69:0)
[05:13:44.628] Timer tick, asking Buildbucket for the build status
[05:13:44.685] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:44.685] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:70:0) after 1m0s
[05:14:44.696] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:70:0)
[05:14:44.696] Timer tick, asking Buildbucket for the build status
[05:14:44.755] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:44.755] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:71:0) after 1m0s
[05:15:44.803] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:71:0)
[05:15:44.803] Timer tick, asking Buildbucket for the build status
[05:15:44.852] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:44.852] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:72:0) after 1m0s
[05:16:44.902] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:72:0)
[05:16:44.902] Timer tick, asking Buildbucket for the build status
[05:16:45.017] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:45.017] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:73:0) after 1m0s
[05:17:45.076] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:73:0)
[05:17:45.076] Timer tick, asking Buildbucket for the build status
[05:17:45.175] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:45.175] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:74:0) after 1m0s
[05:18:45.181] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:74:0)
[05:18:45.181] Timer tick, asking Buildbucket for the build status
[05:18:45.254] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:45.254] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:75:0) after 1m0s
[05:19:45.275] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:75:0)
[05:19:45.275] Timer tick, asking Buildbucket for the build status
[05:19:45.332] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:45.332] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:76:0) after 1m0s
[05:20:45.360] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:76:0)
[05:20:45.360] Timer tick, asking Buildbucket for the build status
[05:20:45.418] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:45.418] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:77:0) after 1m0s
[05:21:45.436] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:77:0)
[05:21:45.436] Timer tick, asking Buildbucket for the build status
[05:21:45.552] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:45.552] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:78:0) after 1m0s
[05:22:45.599] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:78:0)
[05:22:45.599] Timer tick, asking Buildbucket for the build status
[05:22:45.651] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:45.651] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:79:0) after 1m0s
[05:23:45.624] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:79:0)
[05:23:45.624] Timer tick, asking Buildbucket for the build status
[05:23:45.676] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:45.676] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:80:0) after 1m0s
[05:24:45.697] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:80:0)
[05:24:45.697] Timer tick, asking Buildbucket for the build status
[05:24:45.762] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:45.762] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:81:0) after 1m0s
[05:25:45.782] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:81:0)
[05:25:45.782] Timer tick, asking Buildbucket for the build status
[05:25:45.838] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:45.838] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:82:0) after 1m0s
[05:26:45.860] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:82:0)
[05:26:45.860] Timer tick, asking Buildbucket for the build status
[05:26:45.976] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:45.976] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:83:0) after 1m0s
[05:27:46.031] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:83:0)
[05:27:46.031] Timer tick, asking Buildbucket for the build status
[05:27:46.447] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:46.447] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:84:0) after 1m0s
[05:28:46.482] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:84:0)
[05:28:46.482] Timer tick, asking Buildbucket for the build status
[05:28:46.702] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:46.702] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:85:0) after 1m0s
[05:29:46.722] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:85:0)
[05:29:46.722] Timer tick, asking Buildbucket for the build status
[05:29:46.909] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:46.909] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:86:0) after 1m0s
[05:30:46.983] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:86:0)
[05:30:46.983] Timer tick, asking Buildbucket for the build status
[05:30:47.048] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:47.048] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:87:0) after 1m0s
[05:31:47.107] Handling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:87:0)
[05:31:47.107] Timer tick, asking Buildbucket for the build status
[05:31:47.198] Build 8860334484108547744: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:47.198] Scheduling timer "check-buildbucket-build-status" (chromium/android-official:9025764546088453120:88:0) after 1m0s
[05:32:35.570] Received PubSub notification, asking Buildbucket for the build status
[05:32:35.656] Build 8860334484108547744: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:32:35.656] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1608528754412453",
"created_by": "project:chromium",
"created_ts": "1608523589945329",
"id": "8860334484108547744",
"parameters_json": "{\"builder_name\": \"android-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fc46ab79e387af75d5b535da5c92ce03340cc9da\"}}",
"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\": \"fc46ab79e387af75d5b535da5c92ce03340cc9da\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-900-32-0-94fq\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"android-official\", \"buildnumber\": 3298, \"got_angle_revision\": \"ed9213bca0643edb65b7d39a938210419398a1b3\", \"got_dawn_revision\": \"5d4fd88a7403aa255d49919d011af54c691b344a\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"fc46ab79e387af75d5b535da5c92ce03340cc9da\", \"got_revision_cp\": \"refs/heads/master@{#838591}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1cc5b3357d2ff3c81ef7ec0b07a6660796bde5cd\", \"got_v8_revision\": \"73bf5d7db9ade92643424d79b47ac70900843225\", \"got_v8_revision_cp\": \"refs/heads/8.9.178@{#1}\", \"got_webrtc_revision\": \"ef9c4e07a351c9396c72e72efaa1be3df728c440\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32863}\", \"mirrored_builders\": [\"tryserver.chromium:android-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fc46ab79e387af75d5b535da5c92ce03340cc9da\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"android-official\"], \"caches\": [\"builder_ca1514487e4d34b65d6806eb0cd57477702e3b9d413b3212f3f30aa918bed195_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-900-32-0-94fq\"], \"image\": [\"chrome-xenial-20121300-d43316a0aad\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1608523592500290",
"status": "COMPLETED",
"status_changed_ts": "1608528754883231",
"tags": [
"build_address:luci.chromium.ci/android-official/3298",
"builder:android-official",
"buildset:commit/git/fc46ab79e387af75d5b535da5c92ce03340cc9da",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fc46ab79e387af75d5b535da5c92ce03340cc9da",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9025764546088453120",
"scheduler_job_id:chromium/android-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8860334484108547744/+/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:509c4bb41ce91610",
"user_agent:luci-scheduler"
],
"updated_ts": "1608528754920484",
"url": "https://ci.chromium.org/b/8860334484108547744",
"utcnow_ts": "1608528755642227"
}
}
[05:32:35.656] Invocation finished in 1h26m6.982730278s with status SUCCEEDED