[07:00:02.615] New invocation is queued and will start shortly
[07:00:03.658] Starting the invocation (attempt 1)
[07:00:03.702] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:00:03.704] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:00:03.704] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9037259441035159168",
"parameters_json": "{\"builder_name\":\"android-avd-packager\",\"properties\":{}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-avd-packager",
"scheduler_invocation_id:9037259441035159168",
"scheduler_job_id:chromium/android-avd-packager",
"user_agent:luci-scheduler"
]
}
[07:00:04.536] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1597561203803101",
"id": "8871829379119040704",
"parameters_json": "{\"builder_name\": \"android-avd-packager\", \"properties\": {}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-cipd-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1597561204287118",
"tags": [
"build_address:luci.chromium.ci/android-avd-packager/72",
"builder:android-avd-packager",
"scheduler_invocation_id:9037259441035159168",
"scheduler_job_id:chromium/android-avd-packager",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8871829379119040704/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:android/avd_packager",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1597561204287275",
"url": "https://ci.chromium.org/b/8871829379119040704",
"utcnow_ts": "1597561204524208"
}
}
[07:00:04.536] Task URL: https://ci.chromium.org/b/8871829379119040704
[07:00:04.536] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:2:0) after 1m0s
[07:01:04.563] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:2:0)
[07:01:04.563] Timer tick, asking Buildbucket for the build status
[07:01:04.735] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:01:04.735] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:3:0) after 1m0s
[07:02:04.745] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:3:0)
[07:02:04.745] Timer tick, asking Buildbucket for the build status
[07:02:04.817] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:02:04.817] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:4:0) after 1m0s
[07:03:04.888] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:4:0)
[07:03:04.888] Timer tick, asking Buildbucket for the build status
[07:03:05.120] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:03:05.120] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:5:0) after 1m0s
[07:04:05.215] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:5:0)
[07:04:05.215] Timer tick, asking Buildbucket for the build status
[07:04:05.315] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:04:05.315] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:6:0) after 1m0s
[07:05:05.335] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:6:0)
[07:05:05.335] Timer tick, asking Buildbucket for the build status
[07:05:05.586] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:05:05.586] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:7:0) after 1m0s
[07:06:05.631] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:7:0)
[07:06:05.631] Timer tick, asking Buildbucket for the build status
[07:06:05.813] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:06:05.813] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:8:0) after 1m0s
[07:07:05.833] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:8:0)
[07:07:05.833] Timer tick, asking Buildbucket for the build status
[07:07:06.048] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:07:06.048] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:9:0) after 1m0s
[07:08:06.072] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:9:0)
[07:08:06.072] Timer tick, asking Buildbucket for the build status
[07:08:06.159] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:08:06.159] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:10:0) after 1m0s
[07:09:06.192] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:10:0)
[07:09:06.192] Timer tick, asking Buildbucket for the build status
[07:09:06.927] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:09:06.927] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:11:0) after 1m0s
[07:10:07.013] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:11:0)
[07:10:07.013] Timer tick, asking Buildbucket for the build status
[07:10:07.151] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:10:07.151] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:12:0) after 1m0s
[07:11:07.174] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:12:0)
[07:11:07.174] Timer tick, asking Buildbucket for the build status
[07:11:07.284] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:11:07.284] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:13:0) after 1m0s
[07:12:07.315] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:13:0)
[07:12:07.315] Timer tick, asking Buildbucket for the build status
[07:12:07.401] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:12:07.401] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:14:0) after 1m0s
[07:13:07.430] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:14:0)
[07:13:07.430] Timer tick, asking Buildbucket for the build status
[07:13:07.691] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:13:07.691] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:15:0) after 1m0s
[07:14:07.712] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:15:0)
[07:14:07.712] Timer tick, asking Buildbucket for the build status
[07:14:07.865] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:14:07.865] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:16:0) after 1m0s
[07:15:07.891] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:16:0)
[07:15:07.891] Timer tick, asking Buildbucket for the build status
[07:15:07.996] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:15:07.996] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:17:0) after 1m0s
[07:16:08.018] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:17:0)
[07:16:08.018] Timer tick, asking Buildbucket for the build status
[07:16:08.122] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:16:08.122] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:18:0) after 1m0s
[07:17:08.175] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:18:0)
[07:17:08.175] Timer tick, asking Buildbucket for the build status
[07:17:08.261] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:17:08.261] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:19:0) after 1m0s
[07:18:08.291] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:19:0)
[07:18:08.291] Timer tick, asking Buildbucket for the build status
[07:18:08.678] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:18:08.678] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:20:0) after 1m0s
[07:19:08.703] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:20:0)
[07:19:08.703] Timer tick, asking Buildbucket for the build status
[07:19:09.835] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:19:09.835] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:21:0) after 1m0s
[07:20:09.877] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:21:0)
[07:20:09.877] Timer tick, asking Buildbucket for the build status
[07:20:10.042] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:20:10.042] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:22:0) after 1m0s
[07:21:10.067] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:22:0)
[07:21:10.067] Timer tick, asking Buildbucket for the build status
[07:21:10.185] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:21:10.185] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:23:0) after 1m0s
[07:22:10.210] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:23:0)
[07:22:10.210] Timer tick, asking Buildbucket for the build status
[07:22:10.339] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:22:10.339] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:24:0) after 1m0s
[07:23:10.372] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:24:0)
[07:23:10.372] Timer tick, asking Buildbucket for the build status
[07:23:10.520] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:23:10.521] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:25:0) after 1m0s
[07:24:10.559] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:25:0)
[07:24:10.559] Timer tick, asking Buildbucket for the build status
[07:24:10.730] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:24:10.730] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:26:0) after 1m0s
[07:25:10.758] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:26:0)
[07:25:10.758] Timer tick, asking Buildbucket for the build status
[07:25:10.956] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:25:10.956] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:27:0) after 1m0s
[07:26:10.980] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:27:0)
[07:26:10.980] Timer tick, asking Buildbucket for the build status
[07:26:11.097] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:26:11.097] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:28:0) after 1m0s
[07:27:11.126] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:28:0)
[07:27:11.126] Timer tick, asking Buildbucket for the build status
[07:27:11.226] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:27:11.226] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:29:0) after 1m0s
[07:28:11.247] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:29:0)
[07:28:11.247] Timer tick, asking Buildbucket for the build status
[07:28:11.417] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:28:11.417] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:30:0) after 1m0s
[07:29:11.397] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:30:0)
[07:29:11.397] Timer tick, asking Buildbucket for the build status
[07:29:11.563] Build 8871829379119040704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:29:11.563] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:31:0) after 1m0s
[07:30:02.868] Received PubSub notification, asking Buildbucket for the build status
[07:30:02.972] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:11.666] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:31:0)
[07:30:11.666] Timer tick, asking Buildbucket for the build status
[07:30:11.849] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:11.849] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:33:0) after 1m0s
[07:31:11.986] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:33:0)
[07:31:11.986] Timer tick, asking Buildbucket for the build status
[07:31:12.331] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:12.331] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:34:0) after 1m0s
[07:32:12.491] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:34:0)
[07:32:12.491] Timer tick, asking Buildbucket for the build status
[07:32:12.626] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:12.626] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:35:0) after 1m0s
[07:33:12.653] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:35:0)
[07:33:12.653] Timer tick, asking Buildbucket for the build status
[07:33:12.813] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:12.813] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:36:0) after 1m0s
[07:34:12.849] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:36:0)
[07:34:12.849] Timer tick, asking Buildbucket for the build status
[07:34:12.933] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:12.933] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:37:0) after 1m0s
[07:35:13.017] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:37:0)
[07:35:13.017] Timer tick, asking Buildbucket for the build status
[07:35:13.317] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:13.317] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:38:0) after 1m0s
[07:36:13.394] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:38:0)
[07:36:13.394] Timer tick, asking Buildbucket for the build status
[07:36:13.451] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:13.451] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:39:0) after 1m0s
[07:37:13.580] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:39:0)
[07:37:13.581] Timer tick, asking Buildbucket for the build status
[07:37:13.703] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:13.703] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:40:0) after 1m0s
[07:38:13.862] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:40:0)
[07:38:13.862] Timer tick, asking Buildbucket for the build status
[07:38:14.022] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:14.022] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:41:0) after 1m0s
[07:39:14.162] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:41:0)
[07:39:14.162] Timer tick, asking Buildbucket for the build status
[07:39:14.415] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:14.415] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:42:0) after 1m0s
[07:40:14.438] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:42:0)
[07:40:14.438] Timer tick, asking Buildbucket for the build status
[07:40:14.894] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:14.894] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:43:0) after 1m0s
[07:41:15.374] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:43:0)
[07:41:15.374] Timer tick, asking Buildbucket for the build status
[07:41:15.614] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:15.614] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:44:0) after 1m0s
[07:42:15.712] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:44:0)
[07:42:15.712] Timer tick, asking Buildbucket for the build status
[07:42:15.773] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:15.773] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:45:0) after 1m0s
[07:43:16.015] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:45:0)
[07:43:16.015] Timer tick, asking Buildbucket for the build status
[07:43:16.165] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:16.165] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:46:0) after 1m0s
[07:44:16.318] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:46:0)
[07:44:16.319] Timer tick, asking Buildbucket for the build status
[07:44:16.433] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:16.433] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:47:0) after 1m0s
[07:45:16.570] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:47:0)
[07:45:16.570] Timer tick, asking Buildbucket for the build status
[07:45:16.743] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:16.743] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:48:0) after 1m0s
[07:46:16.778] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:48:0)
[07:46:16.778] Timer tick, asking Buildbucket for the build status
[07:46:17.035] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:17.035] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:49:0) after 1m0s
[07:47:17.148] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:49:0)
[07:47:17.148] Timer tick, asking Buildbucket for the build status
[07:47:17.242] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:17.242] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:50:0) after 1m0s
[07:48:17.314] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:50:0)
[07:48:17.314] Timer tick, asking Buildbucket for the build status
[07:48:17.440] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:17.440] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:51:0) after 1m0s
[07:49:17.621] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:51:0)
[07:49:17.621] Timer tick, asking Buildbucket for the build status
[07:49:17.800] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:17.800] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:52:0) after 1m0s
[07:50:18.001] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:52:0)
[07:50:18.001] Timer tick, asking Buildbucket for the build status
[07:50:18.159] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:18.160] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:53:0) after 1m0s
[07:51:18.262] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:53:0)
[07:51:18.262] Timer tick, asking Buildbucket for the build status
[07:51:18.639] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:18.640] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:54:0) after 1m0s
[07:52:18.830] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:54:0)
[07:52:18.830] Timer tick, asking Buildbucket for the build status
[07:52:18.957] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:18.957] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:55:0) after 1m0s
[07:53:19.147] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:55:0)
[07:53:19.147] Timer tick, asking Buildbucket for the build status
[07:53:19.254] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:19.254] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:56:0) after 1m0s
[07:54:19.338] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:56:0)
[07:54:19.338] Timer tick, asking Buildbucket for the build status
[07:54:19.678] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:19.678] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:57:0) after 1m0s
[07:55:19.659] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:57:0)
[07:55:19.659] Timer tick, asking Buildbucket for the build status
[07:55:19.921] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:19.921] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:58:0) after 1m0s
[07:56:20.003] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:58:0)
[07:56:20.003] Timer tick, asking Buildbucket for the build status
[07:56:20.227] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:20.227] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:59:0) after 1m0s
[07:57:20.259] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:59:0)
[07:57:20.259] Timer tick, asking Buildbucket for the build status
[07:57:20.343] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:20.343] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:60:0) after 1m0s
[07:58:20.415] Handling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:60:0)
[07:58:20.415] Timer tick, asking Buildbucket for the build status
[07:58:20.744] Build 8871829379119040704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:20.744] Scheduling timer "check-buildbucket-build-status" (chromium/android-avd-packager:9037259441035159168:61:0) after 1m0s
[07:58:37.466] Received PubSub notification, asking Buildbucket for the build status
[07:58:37.603] Build 8871829379119040704: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:58:37.603] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1597564716212542",
"created_by": "project:chromium",
"created_ts": "1597561203803101",
"id": "8871829379119040704",
"parameters_json": "{\"builder_name\": \"android-avd-packager\", \"properties\": {}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$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}, \"avd_configs\": [\"tools/android/avd/proto/creation/generic_android23.textpb\", \"tools/android/avd/proto/creation/generic_android28.textpb\", \"tools/android/avd/proto/creation/generic_android29.textpb\", \"tools/android/avd/proto/creation/generic_playstore_android28.textpb\"], \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-40-koqq\", \"buildername\": \"android-avd-packager\", \"buildnumber\": 72, \"got_angle_revision\": \"9ae6d7f2ee9e12b707483dc9cadd7c3529595016\", \"got_dawn_revision\": \"5e9b29fab92d6d79125555ea0d84afde9ace908b\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"0e1132cc6ce0b3e1f48b0e86d44ee9acb61fb242\", \"got_revision_cp\": \"refs/heads/master@{#798480}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"abe07b9438553f741e776dedb59a2d4b502a9983\", \"got_v8_revision\": \"7dff8b438cd79eed2033ad513857166a60d1584a\", \"got_v8_revision_cp\": \"refs/heads/8.6.385@{#1}\", \"got_webrtc_revision\": \"383f2cfca4a1ebd9626134101fe70d5a716b2d92\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31921}\", \"path_config\": \"generic\", \"recipe\": \"android/avd_packager\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_510bb217f1fbd7cfc6f82b4f5538258f70582616cab4052bd10c7cd8994fe33a_v2\", \"builder_53a0dbabd2cebac1b8e64bcbfab336eb0021d1dc40b2d4ba5321eb0a070d508c_v2\", \"builder_9abb531f9fa28fcfd3ce68b2370bf6d67201ddb083beddbd2671f7c5fe25be9e_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_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-central1-b-8-40-koqq\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"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\": [\"5488-fc78d20\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-cipd-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1597563001876217",
"status": "COMPLETED",
"status_changed_ts": "1597564716722027",
"tags": [
"build_address:luci.chromium.ci/android-avd-packager/72",
"builder:android-avd-packager",
"scheduler_invocation_id:9037259441035159168",
"scheduler_job_id:chromium/android-avd-packager",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8871829379119040704/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:android/avd_packager",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4e0ee2fc897f3410",
"user_agent:luci-scheduler"
],
"updated_ts": "1597564716731235",
"url": "https://ci.chromium.org/b/8871829379119040704",
"utcnow_ts": "1597564717591673"
}
}
[07:58:37.603] Invocation finished in 58m35.010733022s with status SUCCEEDED