[18:48:04.597] New invocation is queued and will start shortly
[18:48:07.374] Starting the invocation (attempt 1)
[18:48:07.442] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:48:07.443] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:48:07.443] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9044100264887055408",
"parameters_json": "{\"builder_name\":\"android-archive-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b41c92b115bd848347f08e511b4270fe3904a4b3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-archive-rel",
"scheduler_invocation_id:9044100264887055408",
"scheduler_job_id:chromium/android-archive-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/b41c92b115bd848347f08e511b4270fe3904a4b3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b41c92b115bd848347f08e511b4270fe3904a4b3",
"gitiles_ref:refs/heads/master"
]
}
[18:48:09.031] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1591037287652798",
"id": "8878670201021314576",
"parameters_json": "{\"builder_name\": \"android-archive-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b41c92b115bd848347f08e511b4270fe3904a4b3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1591037288306666",
"tags": [
"build_address:luci.chromium.ci/android-archive-rel/12055",
"builder:android-archive-rel",
"buildset:commit/git/b41c92b115bd848347f08e511b4270fe3904a4b3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b41c92b115bd848347f08e511b4270fe3904a4b3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9044100264887055408",
"scheduler_job_id:chromium/android-archive-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8878670201021314576/+/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": "1591037288306816",
"url": "https://ci.chromium.org/b/8878670201021314576",
"utcnow_ts": "1591037288999233"
}
}
[18:48:09.031] Task URL: https://ci.chromium.org/b/8878670201021314576
[18:48:09.031] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:2:0) after 1m0s
[18:49:09.085] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:2:0)
[18:49:09.085] Timer tick, asking Buildbucket for the build status
[18:49:09.233] Build 8878670201021314576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:49:09.233] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:3:0) after 1m0s
[18:50:09.264] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:3:0)
[18:50:09.265] Timer tick, asking Buildbucket for the build status
[18:50:09.427] Build 8878670201021314576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:50:09.427] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:4:0) after 1m0s
[18:51:09.440] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:4:0)
[18:51:09.440] Timer tick, asking Buildbucket for the build status
[18:51:09.742] Build 8878670201021314576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:51:09.742] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:5:0) after 1m0s
[18:52:09.773] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:5:0)
[18:52:09.773] Timer tick, asking Buildbucket for the build status
[18:52:10.218] Build 8878670201021314576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:52:10.218] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:6:0) after 1m0s
[18:53:10.238] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:6:0)
[18:53:10.238] Timer tick, asking Buildbucket for the build status
[18:53:11.550] Build 8878670201021314576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:53:11.550] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:7:0) after 1m0s
[18:53:54.431] Received PubSub notification, asking Buildbucket for the build status
[18:53:54.542] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:11.593] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:7:0)
[18:54:11.593] Timer tick, asking Buildbucket for the build status
[18:54:11.792] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:11.792] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:9:0) after 1m0s
[18:55:11.824] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:9:0)
[18:55:11.824] Timer tick, asking Buildbucket for the build status
[18:55:12.084] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:12.084] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:10:0) after 1m0s
[18:56:12.107] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:10:0)
[18:56:12.107] Timer tick, asking Buildbucket for the build status
[18:56:12.287] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:12.287] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:11:0) after 1m0s
[18:57:12.312] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:11:0)
[18:57:12.312] Timer tick, asking Buildbucket for the build status
[18:57:13.245] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:13.245] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:12:0) after 1m0s
[18:58:13.277] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:12:0)
[18:58:13.277] Timer tick, asking Buildbucket for the build status
[18:58:13.640] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:13.640] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:13:0) after 1m0s
[18:59:13.714] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:13:0)
[18:59:13.714] Timer tick, asking Buildbucket for the build status
[18:59:13.913] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:13.913] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:14:0) after 1m0s
[19:00:13.897] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:14:0)
[19:00:13.897] Timer tick, asking Buildbucket for the build status
[19:00:14.085] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:14.085] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:15:0) after 1m0s
[19:01:14.149] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:15:0)
[19:01:14.149] Timer tick, asking Buildbucket for the build status
[19:01:14.264] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:14.264] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:16:0) after 1m0s
[19:02:14.375] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:16:0)
[19:02:14.375] Timer tick, asking Buildbucket for the build status
[19:02:14.614] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:14.614] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:17:0) after 1m0s
[19:03:14.656] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:17:0)
[19:03:14.656] Timer tick, asking Buildbucket for the build status
[19:03:14.908] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:14.908] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:18:0) after 1m0s
[19:04:14.937] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:18:0)
[19:04:14.937] Timer tick, asking Buildbucket for the build status
[19:04:15.288] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:15.288] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:19:0) after 1m0s
[19:05:15.309] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:19:0)
[19:05:15.309] Timer tick, asking Buildbucket for the build status
[19:05:16.003] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:16.003] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:20:0) after 1m0s
[19:06:16.046] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:20:0)
[19:06:16.046] Timer tick, asking Buildbucket for the build status
[19:06:16.348] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:16.348] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:21:0) after 1m0s
[19:07:16.380] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:21:0)
[19:07:16.380] Timer tick, asking Buildbucket for the build status
[19:07:16.458] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:16.458] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:22:0) after 1m0s
[19:08:16.478] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:22:0)
[19:08:16.478] Timer tick, asking Buildbucket for the build status
[19:08:16.799] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:16.799] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:23:0) after 1m0s
[19:09:16.827] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:23:0)
[19:09:16.827] Timer tick, asking Buildbucket for the build status
[19:09:17.054] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:17.054] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:24:0) after 1m0s
[19:10:17.074] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:24:0)
[19:10:17.074] Timer tick, asking Buildbucket for the build status
[19:10:17.278] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:17.278] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:25:0) after 1m0s
[19:11:17.321] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:25:0)
[19:11:17.321] Timer tick, asking Buildbucket for the build status
[19:11:17.496] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:17.496] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:26:0) after 1m0s
[19:12:17.566] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:26:0)
[19:12:17.566] Timer tick, asking Buildbucket for the build status
[19:12:17.757] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:17.757] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:27:0) after 1m0s
[19:13:17.789] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:27:0)
[19:13:17.789] Timer tick, asking Buildbucket for the build status
[19:13:18.029] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:18.029] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:28:0) after 1m0s
[19:14:18.125] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:28:0)
[19:14:18.125] Timer tick, asking Buildbucket for the build status
[19:14:18.601] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:18.601] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:29:0) after 1m0s
[19:15:18.601] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:29:0)
[19:15:18.601] Timer tick, asking Buildbucket for the build status
[19:15:18.778] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:18.778] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:30:0) after 1m0s
[19:16:18.786] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:30:0)
[19:16:18.786] Timer tick, asking Buildbucket for the build status
[19:16:19.631] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:19.631] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:31:0) after 1m0s
[19:17:19.655] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:31:0)
[19:17:19.655] Timer tick, asking Buildbucket for the build status
[19:17:19.816] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:19.816] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:32:0) after 1m0s
[19:18:19.799] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:32:0)
[19:18:19.799] Timer tick, asking Buildbucket for the build status
[19:18:19.975] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:19.975] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:33:0) after 1m0s
[19:19:19.960] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:33:0)
[19:19:19.960] Timer tick, asking Buildbucket for the build status
[19:19:20.247] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:20.247] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:34:0) after 1m0s
[19:20:20.510] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:34:0)
[19:20:20.510] Timer tick, asking Buildbucket for the build status
[19:20:20.784] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:20.784] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:35:0) after 1m0s
[19:21:20.922] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:35:0)
[19:21:20.922] Timer tick, asking Buildbucket for the build status
[19:21:21.134] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:21.134] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:36:0) after 1m0s
[19:22:21.229] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:36:0)
[19:22:21.229] Timer tick, asking Buildbucket for the build status
[19:22:23.192] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:23.192] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:37:0) after 1m0s
[19:23:23.202] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:37:0)
[19:23:23.202] Timer tick, asking Buildbucket for the build status
[19:23:23.399] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:23.399] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:38:0) after 1m0s
[19:24:23.389] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:38:0)
[19:24:23.389] Timer tick, asking Buildbucket for the build status
[19:24:23.534] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:23.534] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:39:0) after 1m0s
[19:25:23.562] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:39:0)
[19:25:23.562] Timer tick, asking Buildbucket for the build status
[19:25:23.673] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:23.673] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:40:0) after 1m0s
[19:26:23.693] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:40:0)
[19:26:23.693] Timer tick, asking Buildbucket for the build status
[19:26:23.842] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:23.842] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:41:0) after 1m0s
[19:27:23.861] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:41:0)
[19:27:23.861] Timer tick, asking Buildbucket for the build status
[19:27:23.989] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:23.989] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:42:0) after 1m0s
[19:28:26.834] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:42:0)
[19:28:26.834] Timer tick, asking Buildbucket for the build status
[19:28:27.795] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:27.795] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:43:0) after 1m0s
[19:29:27.826] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:43:0)
[19:29:27.826] Timer tick, asking Buildbucket for the build status
[19:29:28.014] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:28.014] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:44:0) after 1m0s
[19:30:28.089] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:44:0)
[19:30:28.089] Timer tick, asking Buildbucket for the build status
[19:30:28.324] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:28.324] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:45:0) after 1m0s
[19:31:28.421] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:45:0)
[19:31:28.421] Timer tick, asking Buildbucket for the build status
[19:31:28.724] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:28.724] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:46:0) after 1m0s
[19:32:28.735] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:46:0)
[19:32:28.735] Timer tick, asking Buildbucket for the build status
[19:32:29.797] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:29.797] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:47:0) after 1m0s
[19:33:29.839] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:47:0)
[19:33:29.839] Timer tick, asking Buildbucket for the build status
[19:33:31.402] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:31.402] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:48:0) after 1m0s
[19:34:31.449] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:48:0)
[19:34:31.449] Timer tick, asking Buildbucket for the build status
[19:34:31.860] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:31.861] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:49:0) after 1m0s
[19:35:31.911] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:49:0)
[19:35:31.911] Timer tick, asking Buildbucket for the build status
[19:35:32.197] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:32.197] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:50:0) after 1m0s
[19:36:32.256] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:50:0)
[19:36:32.256] Timer tick, asking Buildbucket for the build status
[19:36:32.365] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:32.365] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:51:0) after 1m0s
[19:37:32.484] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:51:0)
[19:37:32.484] Timer tick, asking Buildbucket for the build status
[19:37:32.845] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:32.845] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:52:0) after 1m0s
[19:38:33.027] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:52:0)
[19:38:33.027] Timer tick, asking Buildbucket for the build status
[19:38:34.587] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:34.587] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:53:0) after 1m0s
[19:39:34.624] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:53:0)
[19:39:34.624] Timer tick, asking Buildbucket for the build status
[19:39:34.748] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:34.748] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:54:0) after 1m0s
[19:40:34.894] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:54:0)
[19:40:34.894] Timer tick, asking Buildbucket for the build status
[19:40:35.015] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:35.015] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:55:0) after 1m0s
[19:41:35.127] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:55:0)
[19:41:35.127] Timer tick, asking Buildbucket for the build status
[19:41:35.490] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:35.490] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:56:0) after 1m0s
[19:42:35.503] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:56:0)
[19:42:35.503] Timer tick, asking Buildbucket for the build status
[19:42:35.666] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:35.666] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:57:0) after 1m0s
[19:43:35.715] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:57:0)
[19:43:35.715] Timer tick, asking Buildbucket for the build status
[19:43:36.242] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:36.242] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:58:0) after 1m0s
[19:44:36.270] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:58:0)
[19:44:36.270] Timer tick, asking Buildbucket for the build status
[19:44:36.415] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:36.415] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:59:0) after 1m0s
[19:45:36.497] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:59:0)
[19:45:36.497] Timer tick, asking Buildbucket for the build status
[19:45:37.216] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:37.216] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:60:0) after 1m0s
[19:46:37.326] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:60:0)
[19:46:37.326] Timer tick, asking Buildbucket for the build status
[19:46:37.551] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:37.551] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:61:0) after 1m0s
[19:47:37.627] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:61:0)
[19:47:37.627] Timer tick, asking Buildbucket for the build status
[19:47:37.824] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:37.824] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:62:0) after 1m0s
[19:48:37.866] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:62:0)
[19:48:37.866] Timer tick, asking Buildbucket for the build status
[19:48:38.279] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:38.279] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:63:0) after 1m0s
[19:49:38.325] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:63:0)
[19:49:38.325] Timer tick, asking Buildbucket for the build status
[19:49:38.495] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:38.495] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:64:0) after 1m0s
[19:50:38.548] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:64:0)
[19:50:38.548] Timer tick, asking Buildbucket for the build status
[19:50:39.098] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:39.099] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:65:0) after 1m0s
[19:51:39.151] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:65:0)
[19:51:39.151] Timer tick, asking Buildbucket for the build status
[19:51:40.503] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:40.503] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:66:0) after 1m0s
[19:52:40.620] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:66:0)
[19:52:40.620] Timer tick, asking Buildbucket for the build status
[19:52:40.733] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:40.734] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:67:0) after 1m0s
[19:53:40.806] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:67:0)
[19:53:40.806] Timer tick, asking Buildbucket for the build status
[19:53:42.184] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:42.184] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:68:0) after 1m0s
[19:54:42.231] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:68:0)
[19:54:42.231] Timer tick, asking Buildbucket for the build status
[19:54:42.877] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:42.877] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:69:0) after 1m0s
[19:55:42.895] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:69:0)
[19:55:42.895] Timer tick, asking Buildbucket for the build status
[19:55:43.380] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:43.380] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:70:0) after 1m0s
[19:56:43.423] Handling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:70:0)
[19:56:43.423] Timer tick, asking Buildbucket for the build status
[19:56:43.656] Build 8878670201021314576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:43.656] Scheduling timer "check-buildbucket-build-status" (chromium/android-archive-rel:9044100264887055408:71:0) after 1m0s
[19:57:15.722] Received PubSub notification, asking Buildbucket for the build status
[19:57:15.788] Build 8878670201021314576: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:57:15.788] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1591041435057517",
"created_by": "project:chromium",
"created_ts": "1591037287652798",
"id": "8878670201021314576",
"parameters_json": "{\"builder_name\": \"android-archive-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b41c92b115bd848347f08e511b4270fe3904a4b3\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-32-16-sj19\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-archive-rel\", \"buildnumber\": 12055, \"got_angle_revision\": \"b369376270f848bd1ce8aaf98c642a84d680fc4f\", \"got_dawn_revision\": \"13110bff05b85f965c6bff49ee9c7ae3c733598c\", \"got_nacl_revision\": \"87616f7ce2ea8383efd3731960c15f4ba5852d93\", \"got_revision\": \"b41c92b115bd848347f08e511b4270fe3904a4b3\", \"got_revision_cp\": \"refs/heads/master@{#773753}\", \"got_swarming_client_revision\": \"90c5e17a82612bc898c90ab1530dd1bd5822eae8\", \"got_swiftshader_revision\": \"471c120ac92a584e1007f5a3cf22619647bc90a1\", \"got_v8_revision\": \"a411e6d37b57d6f9d322c4e37bc37115e45f05e1\", \"got_v8_revision_cp\": \"refs/heads/8.5.76@{#1}\", \"got_webrtc_revision\": \"00b172a6fa553f02fb50951b6249a67862079a47\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31397}\", \"mastername\": \"chromium\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b41c92b115bd848347f08e511b4270fe3904a4b3\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0264569d20b29e1d5e6df044c8d1223ed84f9f22180c83dac41e8db0ff2b71db_v2\", \"builder_0449d4990cc4feb415a65e31e9088077715ff3aab07ec56c1ca7c39b14a8bb8d_v2\", \"builder_094ae2b7d41fc2d72094b7b6da708c57b0f9cf30da4d1b138156f1458af77f67_v2\", \"builder_39819929c28edbb94cfd890831720319bcf41d58e7ee63cb8a54e18e1fdfd830_v2\", \"builder_924a2904afcfcbbd328cfdc1142e002c0741d79827cb236e881001489d34b9e2_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-16-sj19\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5142-e16b32c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1591037633664343",
"status": "COMPLETED",
"status_changed_ts": "1591041435375991",
"tags": [
"build_address:luci.chromium.ci/android-archive-rel/12055",
"builder:android-archive-rel",
"buildset:commit/git/b41c92b115bd848347f08e511b4270fe3904a4b3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b41c92b115bd848347f08e511b4270fe3904a4b3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9044100264887055408",
"scheduler_job_id:chromium/android-archive-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8878670201021314576/+/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:4c8a07f727fade10",
"user_agent:luci-scheduler"
],
"updated_ts": "1591041435382703",
"url": "https://ci.chromium.org/b/8878670201021314576",
"utcnow_ts": "1591041435781353"
}
}
[19:57:15.789] Invocation finished in 1h9m11.206338484s with status SUCCEEDED