[07:04:56.085] New invocation is queued and will start shortly
[07:04:57.266] Starting the invocation (attempt 1)
[07:04:57.304] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:04:57.305] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:04:57.305] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9085184928528843344",
"parameters_json": "{\"builder_name\":\"Deterministic Android (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"8a908bf3ce2c7940f0a436a38e7249f0c5b5a842\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Android (dbg)",
"scheduler_invocation_id:9085184928528843344",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/8a908bf3ce2c7940f0a436a38e7249f0c5b5a842",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8a908bf3ce2c7940f0a436a38e7249f0c5b5a842",
"gitiles_ref:refs/heads/master"
]
}
[07:04:58.879] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551855897475804",
"experimental": true,
"id": "8919754866407613664",
"lease_expiration_ts": "1551974698217431",
"lease_key": "69733965",
"parameters_json": "{\"builder_name\": \"Deterministic Android (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8a908bf3ce2c7940f0a436a38e7249f0c5b5a842\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1551855898367002",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android (dbg)/4096",
"builder:Deterministic Android (dbg)",
"buildset:commit/git/8a908bf3ce2c7940f0a436a38e7249f0c5b5a842",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8a908bf3ce2c7940f0a436a38e7249f0c5b5a842",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085184928528843344",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8919754866407613664/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:436aa355712b8c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1551855898367123",
"url": "https://ci.chromium.org/b/8919754866407613664",
"utcnow_ts": "1551855898869550"
}
}
[07:04:58.879] Task URL: https://ci.chromium.org/b/8919754866407613664
[07:04:58.879] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:2:0) after 1m0s
[07:05:00.358] Received PubSub notification, asking Buildbucket for the build status
[07:05:00.404] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:58.897] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:2:0)
[07:05:58.897] Timer tick, asking Buildbucket for the build status
[07:05:58.978] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:58.978] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:4:0) after 1m0s
[07:06:58.992] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:4:0)
[07:06:58.992] Timer tick, asking Buildbucket for the build status
[07:06:59.131] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:59.131] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:5:0) after 1m0s
[07:07:59.157] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:5:0)
[07:07:59.157] Timer tick, asking Buildbucket for the build status
[07:07:59.201] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:59.201] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:6:0) after 1m0s
[07:08:59.210] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:6:0)
[07:08:59.210] Timer tick, asking Buildbucket for the build status
[07:08:59.268] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:59.268] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:7:0) after 1m0s
[07:09:59.287] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:7:0)
[07:09:59.287] Timer tick, asking Buildbucket for the build status
[07:09:59.405] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:59.405] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:8:0) after 1m0s
[07:10:59.389] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:8:0)
[07:10:59.389] Timer tick, asking Buildbucket for the build status
[07:10:59.580] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:59.580] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:9:0) after 1m0s
[07:11:59.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:9:0)
[07:11:59.592] Timer tick, asking Buildbucket for the build status
[07:11:59.699] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:59.699] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:10:0) after 1m0s
[07:12:59.706] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:10:0)
[07:12:59.706] Timer tick, asking Buildbucket for the build status
[07:12:59.759] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:59.759] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:11:0) after 1m0s
[07:13:59.780] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:11:0)
[07:13:59.780] Timer tick, asking Buildbucket for the build status
[07:13:59.836] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:59.836] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:12:0) after 1m0s
[07:14:59.858] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:12:0)
[07:14:59.858] Timer tick, asking Buildbucket for the build status
[07:14:59.935] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:59.935] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:13:0) after 1m0s
[07:15:59.924] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:13:0)
[07:15:59.924] Timer tick, asking Buildbucket for the build status
[07:15:59.965] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:59.965] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:14:0) after 1m0s
[07:16:59.984] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:14:0)
[07:16:59.984] Timer tick, asking Buildbucket for the build status
[07:17:00.051] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:00.051] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:15:0) after 1m0s
[07:18:00.051] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:15:0)
[07:18:00.051] Timer tick, asking Buildbucket for the build status
[07:18:00.338] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:00.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:16:0) after 1m0s
[07:19:00.326] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:16:0)
[07:19:00.326] Timer tick, asking Buildbucket for the build status
[07:19:00.394] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:00.394] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:17:0) after 1m0s
[07:20:00.388] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:17:0)
[07:20:00.388] Timer tick, asking Buildbucket for the build status
[07:20:00.485] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:00.485] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:18:0) after 1m0s
[07:21:00.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:18:0)
[07:21:00.522] Timer tick, asking Buildbucket for the build status
[07:21:00.564] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:00.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:19:0) after 1m0s
[07:22:00.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:19:0)
[07:22:00.586] Timer tick, asking Buildbucket for the build status
[07:22:00.650] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:00.650] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:20:0) after 1m0s
[07:23:00.669] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:20:0)
[07:23:00.669] Timer tick, asking Buildbucket for the build status
[07:23:00.784] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:00.784] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:21:0) after 1m0s
[07:24:00.788] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:21:0)
[07:24:00.788] Timer tick, asking Buildbucket for the build status
[07:24:00.848] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:00.848] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:22:0) after 1m0s
[07:25:00.868] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:22:0)
[07:25:00.868] Timer tick, asking Buildbucket for the build status
[07:25:01.103] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:01.103] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:23:0) after 1m0s
[07:26:01.140] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:23:0)
[07:26:01.140] Timer tick, asking Buildbucket for the build status
[07:26:01.213] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:01.213] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:24:0) after 1m0s
[07:27:01.230] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:24:0)
[07:27:01.230] Timer tick, asking Buildbucket for the build status
[07:27:01.270] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:01.270] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:25:0) after 1m0s
[07:28:01.265] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:25:0)
[07:28:01.265] Timer tick, asking Buildbucket for the build status
[07:28:01.401] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:01.401] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:26:0) after 1m0s
[07:29:01.387] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:26:0)
[07:29:01.387] Timer tick, asking Buildbucket for the build status
[07:29:01.453] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:01.453] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:27:0) after 1m0s
[07:30:01.460] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:27:0)
[07:30:01.460] Timer tick, asking Buildbucket for the build status
[07:30:01.576] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:01.576] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:28:0) after 1m0s
[07:31:01.643] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:28:0)
[07:31:01.643] Timer tick, asking Buildbucket for the build status
[07:31:01.778] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:01.778] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:29:0) after 1m0s
[07:32:01.800] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:29:0)
[07:32:01.800] Timer tick, asking Buildbucket for the build status
[07:32:01.839] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:01.839] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:30:0) after 1m0s
[07:33:01.852] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:30:0)
[07:33:01.852] Timer tick, asking Buildbucket for the build status
[07:33:01.922] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:01.922] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:31:0) after 1m0s
[07:34:01.936] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:31:0)
[07:34:01.936] Timer tick, asking Buildbucket for the build status
[07:34:01.992] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:01.992] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:32:0) after 1m0s
[07:35:02.008] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:32:0)
[07:35:02.008] Timer tick, asking Buildbucket for the build status
[07:35:02.059] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:02.059] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:33:0) after 1m0s
[07:36:02.069] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:33:0)
[07:36:02.069] Timer tick, asking Buildbucket for the build status
[07:36:02.120] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:02.120] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:34:0) after 1m0s
[07:37:02.131] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:34:0)
[07:37:02.131] Timer tick, asking Buildbucket for the build status
[07:37:02.177] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:02.177] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:35:0) after 1m0s
[07:38:02.216] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:35:0)
[07:38:02.216] Timer tick, asking Buildbucket for the build status
[07:38:02.372] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:02.372] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:36:0) after 1m0s
[07:39:02.353] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:36:0)
[07:39:02.353] Timer tick, asking Buildbucket for the build status
[07:39:02.394] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:02.394] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:37:0) after 1m0s
[07:40:02.414] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:37:0)
[07:40:02.414] Timer tick, asking Buildbucket for the build status
[07:40:02.496] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:02.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:38:0) after 1m0s
[07:41:02.489] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:38:0)
[07:41:02.489] Timer tick, asking Buildbucket for the build status
[07:41:02.583] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:02.583] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:39:0) after 1m0s
[07:42:02.580] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:39:0)
[07:42:02.580] Timer tick, asking Buildbucket for the build status
[07:42:03.066] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:03.066] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:40:0) after 1m0s
[07:43:03.088] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:40:0)
[07:43:03.088] Timer tick, asking Buildbucket for the build status
[07:43:03.193] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:03.193] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:41:0) after 1m0s
[07:44:03.178] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:41:0)
[07:44:03.178] Timer tick, asking Buildbucket for the build status
[07:44:03.241] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:03.241] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:42:0) after 1m0s
[07:45:03.252] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:42:0)
[07:45:03.252] Timer tick, asking Buildbucket for the build status
[07:45:03.292] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:03.292] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:43:0) after 1m0s
[07:46:03.290] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:43:0)
[07:46:03.290] Timer tick, asking Buildbucket for the build status
[07:46:03.446] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:03.446] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:44:0) after 1m0s
[07:47:03.466] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:44:0)
[07:47:03.466] Timer tick, asking Buildbucket for the build status
[07:47:03.907] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:03.907] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:45:0) after 1m0s
[07:48:03.935] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:45:0)
[07:48:03.935] Timer tick, asking Buildbucket for the build status
[07:48:03.984] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:03.984] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:46:0) after 1m0s
[07:49:04.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:46:0)
[07:49:04.037] Timer tick, asking Buildbucket for the build status
[07:49:04.120] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:04.120] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:47:0) after 1m0s
[07:50:04.095] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:47:0)
[07:50:04.095] Timer tick, asking Buildbucket for the build status
[07:50:04.142] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:04.142] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:48:0) after 1m0s
[07:51:04.157] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:48:0)
[07:51:04.157] Timer tick, asking Buildbucket for the build status
[07:51:04.269] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:04.269] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:49:0) after 1m0s
[07:52:04.287] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:49:0)
[07:52:04.288] Timer tick, asking Buildbucket for the build status
[07:52:04.473] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:04.473] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:50:0) after 1m0s
[07:53:04.499] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:50:0)
[07:53:04.499] Timer tick, asking Buildbucket for the build status
[07:53:04.722] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:04.722] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:51:0) after 1m0s
[07:54:04.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:51:0)
[07:54:04.745] Timer tick, asking Buildbucket for the build status
[07:54:04.988] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:04.988] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:52:0) after 1m0s
[07:55:04.970] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:52:0)
[07:55:04.970] Timer tick, asking Buildbucket for the build status
[07:55:05.196] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:05.196] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:53:0) after 1m0s
[07:56:05.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:53:0)
[07:56:05.218] Timer tick, asking Buildbucket for the build status
[07:56:05.263] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:05.263] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:54:0) after 1m0s
[07:57:05.293] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:54:0)
[07:57:05.293] Timer tick, asking Buildbucket for the build status
[07:57:05.491] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:05.491] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:55:0) after 1m0s
[07:58:05.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:55:0)
[07:58:05.493] Timer tick, asking Buildbucket for the build status
[07:58:05.534] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:05.534] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:56:0) after 1m0s
[07:59:05.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:56:0)
[07:59:05.563] Timer tick, asking Buildbucket for the build status
[07:59:05.692] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:05.692] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:57:0) after 1m0s
[08:00:05.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:57:0)
[08:00:05.679] Timer tick, asking Buildbucket for the build status
[08:00:05.744] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:05.744] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:58:0) after 1m0s
[08:01:05.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:58:0)
[08:01:05.728] Timer tick, asking Buildbucket for the build status
[08:01:05.767] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:05.767] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:59:0) after 1m0s
[08:02:05.781] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:59:0)
[08:02:05.781] Timer tick, asking Buildbucket for the build status
[08:02:06.139] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:06.139] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:60:0) after 1m0s
[08:03:06.123] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:60:0)
[08:03:06.123] Timer tick, asking Buildbucket for the build status
[08:03:06.182] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:06.182] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:61:0) after 1m0s
[08:04:06.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:61:0)
[08:04:06.218] Timer tick, asking Buildbucket for the build status
[08:04:06.257] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:06.257] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:62:0) after 1m0s
[08:05:06.268] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:62:0)
[08:05:06.268] Timer tick, asking Buildbucket for the build status
[08:05:06.608] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:06.608] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:63:0) after 1m0s
[08:06:06.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:63:0)
[08:06:06.631] Timer tick, asking Buildbucket for the build status
[08:06:06.671] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:06.671] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:64:0) after 1m0s
[08:07:06.756] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:64:0)
[08:07:06.756] Timer tick, asking Buildbucket for the build status
[08:07:06.842] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:06.842] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:65:0) after 1m0s
[08:08:06.822] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:65:0)
[08:08:06.822] Timer tick, asking Buildbucket for the build status
[08:08:06.982] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:06.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:66:0) after 1m0s
[08:09:07.006] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:66:0)
[08:09:07.006] Timer tick, asking Buildbucket for the build status
[08:09:07.084] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:07.084] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:67:0) after 1m0s
[08:10:07.093] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:67:0)
[08:10:07.093] Timer tick, asking Buildbucket for the build status
[08:10:07.499] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:07.499] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:68:0) after 1m0s
[08:11:07.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:68:0)
[08:11:07.527] Timer tick, asking Buildbucket for the build status
[08:11:07.655] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:07.655] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:69:0) after 1m0s
[08:12:07.647] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:69:0)
[08:12:07.647] Timer tick, asking Buildbucket for the build status
[08:12:07.687] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:07.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:70:0) after 1m0s
[08:13:07.710] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:70:0)
[08:13:07.710] Timer tick, asking Buildbucket for the build status
[08:13:07.746] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:07.746] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:71:0) after 1m0s
[08:14:07.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:71:0)
[08:14:07.744] Timer tick, asking Buildbucket for the build status
[08:14:07.782] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:07.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:72:0) after 1m0s
[08:15:07.776] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:72:0)
[08:15:07.776] Timer tick, asking Buildbucket for the build status
[08:15:07.966] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:07.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:73:0) after 1m0s
[08:16:07.991] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:73:0)
[08:16:07.991] Timer tick, asking Buildbucket for the build status
[08:16:08.055] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:08.055] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:74:0) after 1m0s
[08:17:08.049] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:74:0)
[08:17:08.049] Timer tick, asking Buildbucket for the build status
[08:17:08.095] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:08.095] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:75:0) after 1m0s
[08:18:08.131] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:75:0)
[08:18:08.131] Timer tick, asking Buildbucket for the build status
[08:18:08.295] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:08.295] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:76:0) after 1m0s
[08:19:08.329] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:76:0)
[08:19:08.329] Timer tick, asking Buildbucket for the build status
[08:19:08.496] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:08.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:77:0) after 1m0s
[08:20:08.496] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:77:0)
[08:20:08.496] Timer tick, asking Buildbucket for the build status
[08:20:08.532] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:08.532] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:78:0) after 1m0s
[08:21:08.561] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:78:0)
[08:21:08.561] Timer tick, asking Buildbucket for the build status
[08:21:08.627] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:08.627] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:79:0) after 1m0s
[08:22:08.663] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:79:0)
[08:22:08.663] Timer tick, asking Buildbucket for the build status
[08:22:08.913] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:08.913] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:80:0) after 1m0s
[08:23:08.944] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:80:0)
[08:23:08.944] Timer tick, asking Buildbucket for the build status
[08:23:09.097] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:09.097] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:81:0) after 1m0s
[08:24:09.122] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:81:0)
[08:24:09.122] Timer tick, asking Buildbucket for the build status
[08:24:09.240] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:09.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:82:0) after 1m0s
[08:25:09.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:82:0)
[08:25:09.218] Timer tick, asking Buildbucket for the build status
[08:25:09.294] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:09.294] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:83:0) after 1m0s
[08:26:09.328] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:83:0)
[08:26:09.328] Timer tick, asking Buildbucket for the build status
[08:26:09.369] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:09.369] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:84:0) after 1m0s
[08:27:09.394] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:84:0)
[08:27:09.394] Timer tick, asking Buildbucket for the build status
[08:27:09.508] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:09.508] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:85:0) after 1m0s
[08:28:09.502] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:85:0)
[08:28:09.502] Timer tick, asking Buildbucket for the build status
[08:28:09.547] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:09.547] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:86:0) after 1m0s
[08:29:09.539] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:86:0)
[08:29:09.539] Timer tick, asking Buildbucket for the build status
[08:29:09.600] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:09.600] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:87:0) after 1m0s
[08:30:09.601] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:87:0)
[08:30:09.601] Timer tick, asking Buildbucket for the build status
[08:30:09.781] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:09.781] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:88:0) after 1m0s
[08:31:09.786] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:88:0)
[08:31:09.786] Timer tick, asking Buildbucket for the build status
[08:31:09.826] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:09.826] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:89:0) after 1m0s
[08:32:09.847] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:89:0)
[08:32:09.847] Timer tick, asking Buildbucket for the build status
[08:32:09.890] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:09.890] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:90:0) after 1m0s
[08:33:09.918] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:90:0)
[08:33:09.918] Timer tick, asking Buildbucket for the build status
[08:33:09.967] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:09.967] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:91:0) after 1m0s
[08:34:09.994] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:91:0)
[08:34:09.994] Timer tick, asking Buildbucket for the build status
[08:34:10.097] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:10.097] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:92:0) after 1m0s
[08:35:10.140] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:92:0)
[08:35:10.140] Timer tick, asking Buildbucket for the build status
[08:35:10.193] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:10.193] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:93:0) after 1m0s
[08:36:10.202] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:93:0)
[08:36:10.202] Timer tick, asking Buildbucket for the build status
[08:36:10.279] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:10.279] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:94:0) after 1m0s
[08:37:10.283] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:94:0)
[08:37:10.283] Timer tick, asking Buildbucket for the build status
[08:37:10.322] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:10.322] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:95:0) after 1m0s
[08:38:10.305] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:95:0)
[08:38:10.305] Timer tick, asking Buildbucket for the build status
[08:38:10.342] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:10.342] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:96:0) after 1m0s
[08:39:10.334] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:96:0)
[08:39:10.334] Timer tick, asking Buildbucket for the build status
[08:39:10.562] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:10.562] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:97:0) after 1m0s
[08:40:10.578] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:97:0)
[08:40:10.578] Timer tick, asking Buildbucket for the build status
[08:40:10.676] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:10.676] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:98:0) after 1m0s
[08:41:10.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:98:0)
[08:41:10.700] Timer tick, asking Buildbucket for the build status
[08:41:10.788] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:10.788] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:99:0) after 1m0s
[08:42:10.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:99:0)
[08:42:10.820] Timer tick, asking Buildbucket for the build status
[08:42:10.961] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:10.961] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:100:0) after 1m0s
[08:43:11.058] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:100:0)
[08:43:11.058] Timer tick, asking Buildbucket for the build status
[08:43:11.105] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:11.105] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:101:0) after 1m0s
[08:44:11.088] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:101:0)
[08:44:11.088] Timer tick, asking Buildbucket for the build status
[08:44:11.194] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:11.194] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:102:0) after 1m0s
[08:45:11.260] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:102:0)
[08:45:11.260] Timer tick, asking Buildbucket for the build status
[08:45:11.306] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:11.306] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:103:0) after 1m0s
[08:46:11.295] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:103:0)
[08:46:11.295] Timer tick, asking Buildbucket for the build status
[08:46:11.332] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:11.332] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:104:0) after 1m0s
[08:47:11.360] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:104:0)
[08:47:11.360] Timer tick, asking Buildbucket for the build status
[08:47:11.412] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:11.412] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:105:0) after 1m0s
[08:48:11.426] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:105:0)
[08:48:11.426] Timer tick, asking Buildbucket for the build status
[08:48:11.481] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:11.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:106:0) after 1m0s
[08:49:11.500] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:106:0)
[08:49:11.500] Timer tick, asking Buildbucket for the build status
[08:49:11.692] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:11.693] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:107:0) after 1m0s
[08:50:11.718] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:107:0)
[08:50:11.718] Timer tick, asking Buildbucket for the build status
[08:50:11.760] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:11.760] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:108:0) after 1m0s
[08:51:11.789] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:108:0)
[08:51:11.789] Timer tick, asking Buildbucket for the build status
[08:51:11.890] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:11.891] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:109:0) after 1m0s
[08:52:11.966] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:109:0)
[08:52:11.966] Timer tick, asking Buildbucket for the build status
[08:52:12.288] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:12.288] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:110:0) after 1m0s
[08:53:12.334] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:110:0)
[08:53:12.334] Timer tick, asking Buildbucket for the build status
[08:53:12.387] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:12.387] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:111:0) after 1m0s
[08:54:12.433] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:111:0)
[08:54:12.433] Timer tick, asking Buildbucket for the build status
[08:54:12.482] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:12.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:112:0) after 1m0s
[08:55:12.490] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:112:0)
[08:55:12.490] Timer tick, asking Buildbucket for the build status
[08:55:12.528] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:12.528] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:113:0) after 1m0s
[08:56:12.523] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:113:0)
[08:56:12.523] Timer tick, asking Buildbucket for the build status
[08:56:12.617] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:12.617] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:114:0) after 1m0s
[08:57:12.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:114:0)
[08:57:12.596] Timer tick, asking Buildbucket for the build status
[08:57:12.638] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:12.638] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:115:0) after 1m0s
[08:58:12.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:115:0)
[08:58:12.666] Timer tick, asking Buildbucket for the build status
[08:58:12.710] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:12.710] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:116:0) after 1m0s
[08:59:12.736] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:116:0)
[08:59:12.736] Timer tick, asking Buildbucket for the build status
[08:59:12.800] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:12.800] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:117:0) after 1m0s
[09:00:12.822] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:117:0)
[09:00:12.822] Timer tick, asking Buildbucket for the build status
[09:00:12.956] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:12.956] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:118:0) after 1m0s
[09:01:12.965] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:118:0)
[09:01:12.965] Timer tick, asking Buildbucket for the build status
[09:01:13.076] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:13.076] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:119:0) after 1m0s
[09:02:13.095] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:119:0)
[09:02:13.095] Timer tick, asking Buildbucket for the build status
[09:02:13.139] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:13.139] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:120:0) after 1m0s
[09:03:13.180] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:120:0)
[09:03:13.180] Timer tick, asking Buildbucket for the build status
[09:03:13.224] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:13.224] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:121:0) after 1m0s
[09:04:13.257] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:121:0)
[09:04:13.257] Timer tick, asking Buildbucket for the build status
[09:04:13.325] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:13.325] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:122:0) after 1m0s
[09:05:13.363] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:122:0)
[09:05:13.363] Timer tick, asking Buildbucket for the build status
[09:05:13.487] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:13.487] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:123:0) after 1m0s
[09:06:13.515] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:123:0)
[09:06:13.515] Timer tick, asking Buildbucket for the build status
[09:06:13.554] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:13.554] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:124:0) after 1m0s
[09:07:13.538] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:124:0)
[09:07:13.538] Timer tick, asking Buildbucket for the build status
[09:07:13.604] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:13.604] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:125:0) after 1m0s
[09:08:13.652] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:125:0)
[09:08:13.652] Timer tick, asking Buildbucket for the build status
[09:08:13.804] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:13.804] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:126:0) after 1m0s
[09:09:13.871] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:126:0)
[09:09:13.871] Timer tick, asking Buildbucket for the build status
[09:09:13.992] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:13.992] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:127:0) after 1m0s
[09:10:14.034] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:127:0)
[09:10:14.034] Timer tick, asking Buildbucket for the build status
[09:10:14.107] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:14.107] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:128:0) after 1m0s
[09:11:14.144] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:128:0)
[09:11:14.144] Timer tick, asking Buildbucket for the build status
[09:11:14.256] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:14.256] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:129:0) after 1m0s
[09:12:14.293] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:129:0)
[09:12:14.293] Timer tick, asking Buildbucket for the build status
[09:12:14.481] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:14.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:130:0) after 1m0s
[09:13:14.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:130:0)
[09:13:14.493] Timer tick, asking Buildbucket for the build status
[09:13:14.584] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:14.584] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:131:0) after 1m0s
[09:14:14.597] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:131:0)
[09:14:14.597] Timer tick, asking Buildbucket for the build status
[09:14:14.645] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:14.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:132:0) after 1m0s
[09:15:14.669] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:132:0)
[09:15:14.669] Timer tick, asking Buildbucket for the build status
[09:15:14.853] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:14.853] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:133:0) after 1m0s
[09:16:14.870] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:133:0)
[09:16:14.870] Timer tick, asking Buildbucket for the build status
[09:16:14.985] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:14.985] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:134:0) after 1m0s
[09:17:15.008] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:134:0)
[09:17:15.008] Timer tick, asking Buildbucket for the build status
[09:17:15.110] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:15.110] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:135:0) after 1m0s
[09:18:15.131] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:135:0)
[09:18:15.131] Timer tick, asking Buildbucket for the build status
[09:18:15.175] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:15.175] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:136:0) after 1m0s
[09:19:15.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:136:0)
[09:19:15.208] Timer tick, asking Buildbucket for the build status
[09:19:15.286] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:15.286] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:137:0) after 1m0s
[09:20:15.319] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:137:0)
[09:20:15.319] Timer tick, asking Buildbucket for the build status
[09:20:15.364] Build 8919754866407613664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:15.364] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9085184928528843344:138:0) after 1m0s
[09:21:12.550] Received PubSub notification, asking Buildbucket for the build status
[09:21:12.606] Build 8919754866407613664: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:21:12.607] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1551864071472241",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551855897475804",
"experimental": true,
"id": "8919754866407613664",
"parameters_json": "{\"builder_name\": \"Deterministic Android (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8a908bf3ce2c7940f0a436a38e7249f0c5b5a842\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Deterministic Android (dbg)\"], \"kvm\": [\"1\"], \"id\": [\"gce-trusty-e833d7b0-us-west1-a-3121\"], \"server_version\": [\"4143-92e279d\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-a\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_2bff2df219af63c0787c4be2031d3fbd218ec1b0853f1b8ce80b2331f0e04ffd_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"ui\": {\"info\": \"\"}, \"properties\": {\"got_nacl_revision\": \"1ed9878b8eb68c1e0d0268754dafcf83e747fa8f\", \"got_swarming_client_revision\": \"7a61cf37d6a0163f0ec02d495289a1d038e62457\", \"got_revision\": \"8a908bf3ce2c7940f0a436a38e7249f0c5b5a842\", \"recipe\": \"swarming/deterministic_build\", \"got_dawn_revision\": \"b47470daa7377a804df5d94e7a93b5925a57f84a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#26973}\", \"$build/goma\": {\"jobs\": 150.0}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"got_revision_cp\": \"refs/heads/master@{#638036}\", \"branch\": \"refs/heads/master\", \"revision\": \"8a908bf3ce2c7940f0a436a38e7249f0c5b5a842\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Deterministic Android (dbg)\", \"got_webrtc_revision\": \"d36c08623d9085dad821fbb1462a7fe03badcef5\", \"mastername\": \"chromium.android\", \"$recipe_engine/runtime\": {\"is_experimental\": true, \"is_luci\": true}, \"got_v8_revision\": \"3e8a733af17a7812eba188dad612be503bd45c57\", \"got_v8_revision_cp\": \"refs/heads/7.4.288@{#1}\", \"got_angle_revision\": \"f094bac949922dabc3dd6944f3dec04111e953b6\", \"buildnumber\": 4096, \"path_config\": \"generic\", \"bot_id\": \"gce-trusty-e833d7b0-us-west1-a-3121\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1551855899595393",
"status": "COMPLETED",
"status_changed_ts": "1551864072180890",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android (dbg)/4096",
"builder:Deterministic Android (dbg)",
"buildset:commit/git/8a908bf3ce2c7940f0a436a38e7249f0c5b5a842",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8a908bf3ce2c7940f0a436a38e7249f0c5b5a842",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085184928528843344",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8919754866407613664/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:436aa355712b8c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1551864072182759",
"url": "https://ci.chromium.org/b/8919754866407613664",
"utcnow_ts": "1551864072594230"
}
}
[09:21:12.607] Invocation finished in 2h16m16.538883789s with status SUCCEEDED