[20:46:42.186] New invocation is queued and will start shortly
[20:46:44.251] Starting the invocation (attempt 1)
[20:46:44.293] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:46:44.293] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:46:44.338] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9111406347611716080",
"parameters_json": "{\"builder_name\":\"Deterministic Android\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"2d201b10f2b2b104928993f680ad2b02d1ca0cdb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Android",
"scheduler_invocation_id:9111406347611716080",
"scheduler_job_id:chromium/Deterministic Android",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2d201b10f2b2b104928993f680ad2b02d1ca0cdb",
"gitiles_ref:refs/heads/master"
]
}
[20:46:47.752] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1526849204408210",
"experimental": true,
"id": "8945976284596902112",
"lease_expiration_ts": "1526885206152600",
"lease_key": "1932353851",
"parameters_json": "{\"builder_name\": \"Deterministic Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"2d201b10f2b2b104928993f680ad2b02d1ca0cdb\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1526849207303510",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android/1505",
"builder:Deterministic Android",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2d201b10f2b2b104928993f680ad2b02d1ca0cdb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9111406347611716080",
"scheduler_job_id:chromium/Deterministic Android",
"swarming_dimension:builder:Deterministic Android",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Deterministic Android/1505",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8945976284596902112",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:06be006c935279af3663102925cce4dcc526e425",
"swarming_tag:builder:Deterministic Android",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2d201b10f2b2b104928993f680ad2b02d1ca0cdb",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8945976284596902112/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:60",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9111406347611716080",
"swarming_tag:scheduler_job_id:chromium/Deterministic Android",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3d981f7d18dac510",
"user_agent:luci-scheduler"
],
"updated_ts": "1526849207303550",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Deterministic Android/1505",
"utcnow_ts": "1526849207719260"
}
}
[20:46:47.752] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Deterministic Android/1505
[20:46:47.752] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:2:0) after 1m0s
[20:47:20.631] Received PubSub notification, asking Buildbucket for the build status
[20:47:20.811] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:47.793] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:2:0)
[20:47:47.793] Timer tick, asking Buildbucket for the build status
[20:47:47.827] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:47.827] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:4:0) after 1m0s
[20:48:47.846] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:4:0)
[20:48:47.846] Timer tick, asking Buildbucket for the build status
[20:48:48.073] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:48.073] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:5:0) after 1m0s
[20:49:48.090] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:5:0)
[20:49:48.090] Timer tick, asking Buildbucket for the build status
[20:49:48.227] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:48.227] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:6:0) after 1m0s
[20:50:48.249] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:6:0)
[20:50:48.249] Timer tick, asking Buildbucket for the build status
[20:50:48.315] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:48.315] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:7:0) after 1m0s
[20:51:48.388] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:7:0)
[20:51:48.388] Timer tick, asking Buildbucket for the build status
[20:51:48.511] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:48.511] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:8:0) after 1m0s
[20:52:48.526] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:8:0)
[20:52:48.526] Timer tick, asking Buildbucket for the build status
[20:52:48.614] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:48.614] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:9:0) after 1m0s
[20:53:48.632] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:9:0)
[20:53:48.632] Timer tick, asking Buildbucket for the build status
[20:53:48.745] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:48.745] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:10:0) after 1m0s
[20:54:48.760] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:10:0)
[20:54:48.760] Timer tick, asking Buildbucket for the build status
[20:54:48.903] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:48.903] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:11:0) after 1m0s
[20:55:48.921] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:11:0)
[20:55:48.921] Timer tick, asking Buildbucket for the build status
[20:55:48.980] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:48.980] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:12:0) after 1m0s
[20:56:48.996] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:12:0)
[20:56:48.996] Timer tick, asking Buildbucket for the build status
[20:56:49.230] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:49.230] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:13:0) after 1m0s
[20:57:49.250] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:13:0)
[20:57:49.250] Timer tick, asking Buildbucket for the build status
[20:57:49.362] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:49.362] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:14:0) after 1m0s
[20:58:49.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:14:0)
[20:58:49.378] Timer tick, asking Buildbucket for the build status
[20:58:49.476] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:49.476] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:15:0) after 1m0s
[20:59:49.494] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:15:0)
[20:59:49.494] Timer tick, asking Buildbucket for the build status
[20:59:49.553] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:49.553] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:16:0) after 1m0s
[21:00:49.582] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:16:0)
[21:00:49.582] Timer tick, asking Buildbucket for the build status
[21:00:49.725] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:49.725] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:17:0) after 1m0s
[21:01:49.743] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:17:0)
[21:01:49.743] Timer tick, asking Buildbucket for the build status
[21:01:49.812] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:49.812] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:18:0) after 1m0s
[21:02:49.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:18:0)
[21:02:49.854] Timer tick, asking Buildbucket for the build status
[21:02:49.919] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:49.919] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:19:0) after 1m0s
[21:03:49.971] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:19:0)
[21:03:49.971] Timer tick, asking Buildbucket for the build status
[21:03:50.060] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:50.060] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:20:0) after 1m0s
[21:04:50.148] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:20:0)
[21:04:50.148] Timer tick, asking Buildbucket for the build status
[21:04:50.246] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:50.246] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:21:0) after 1m0s
[21:05:50.288] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:21:0)
[21:05:50.289] Timer tick, asking Buildbucket for the build status
[21:05:50.371] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:50.371] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:22:0) after 1m0s
[21:06:50.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:22:0)
[21:06:50.398] Timer tick, asking Buildbucket for the build status
[21:06:50.459] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:50.459] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:23:0) after 1m0s
[21:07:50.479] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:23:0)
[21:07:50.479] Timer tick, asking Buildbucket for the build status
[21:07:50.635] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:50.635] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:24:0) after 1m0s
[21:08:50.651] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:24:0)
[21:08:50.651] Timer tick, asking Buildbucket for the build status
[21:08:50.735] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:50.735] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:25:0) after 1m0s
[21:09:50.814] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:25:0)
[21:09:50.814] Timer tick, asking Buildbucket for the build status
[21:09:50.926] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:50.926] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:26:0) after 1m0s
[21:10:50.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:26:0)
[21:10:50.979] Timer tick, asking Buildbucket for the build status
[21:10:51.113] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:51.113] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:27:0) after 1m0s
[21:11:51.246] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:27:0)
[21:11:51.246] Timer tick, asking Buildbucket for the build status
[21:11:51.379] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:51.380] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:28:0) after 1m0s
[21:12:51.438] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:28:0)
[21:12:51.438] Timer tick, asking Buildbucket for the build status
[21:12:51.646] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:51.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:29:0) after 1m0s
[21:13:51.665] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:29:0)
[21:13:51.665] Timer tick, asking Buildbucket for the build status
[21:13:51.717] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:51.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:30:0) after 1m0s
[21:14:51.743] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:30:0)
[21:14:51.743] Timer tick, asking Buildbucket for the build status
[21:14:51.802] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:51.802] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:31:0) after 1m0s
[21:15:51.890] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:31:0)
[21:15:51.890] Timer tick, asking Buildbucket for the build status
[21:15:51.948] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:51.948] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:32:0) after 1m0s
[21:16:52.045] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:32:0)
[21:16:52.045] Timer tick, asking Buildbucket for the build status
[21:16:52.178] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:52.178] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:33:0) after 1m0s
[21:17:52.307] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:33:0)
[21:17:52.307] Timer tick, asking Buildbucket for the build status
[21:17:52.381] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:52.381] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:34:0) after 1m0s
[21:18:52.463] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:34:0)
[21:18:52.463] Timer tick, asking Buildbucket for the build status
[21:18:52.639] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:52.639] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:35:0) after 1m0s
[21:19:52.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:35:0)
[21:19:52.656] Timer tick, asking Buildbucket for the build status
[21:19:52.748] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:52.748] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:36:0) after 1m0s
[21:20:52.769] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:36:0)
[21:20:52.769] Timer tick, asking Buildbucket for the build status
[21:20:52.867] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:52.867] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:37:0) after 1m0s
[21:21:52.890] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:37:0)
[21:21:52.890] Timer tick, asking Buildbucket for the build status
[21:21:53.353] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:53.353] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:38:0) after 1m0s
[21:22:53.440] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:38:0)
[21:22:53.440] Timer tick, asking Buildbucket for the build status
[21:22:53.636] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:53.637] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:39:0) after 1m0s
[21:23:53.653] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:39:0)
[21:23:53.653] Timer tick, asking Buildbucket for the build status
[21:23:53.763] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:53.763] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:40:0) after 1m0s
[21:24:53.812] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:40:0)
[21:24:53.812] Timer tick, asking Buildbucket for the build status
[21:24:53.912] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:53.912] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:41:0) after 1m0s
[21:25:54.017] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:41:0)
[21:25:54.017] Timer tick, asking Buildbucket for the build status
[21:25:54.230] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:54.230] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:42:0) after 1m0s
[21:26:54.335] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:42:0)
[21:26:54.335] Timer tick, asking Buildbucket for the build status
[21:26:54.410] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:54.410] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:43:0) after 1m0s
[21:27:54.488] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:43:0)
[21:27:54.488] Timer tick, asking Buildbucket for the build status
[21:27:54.576] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:54.576] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:44:0) after 1m0s
[21:28:54.687] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:44:0)
[21:28:54.687] Timer tick, asking Buildbucket for the build status
[21:28:54.779] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:54.779] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:45:0) after 1m0s
[21:29:54.806] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:45:0)
[21:29:54.806] Timer tick, asking Buildbucket for the build status
[21:29:55.005] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:55.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:46:0) after 1m0s
[21:30:55.026] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:46:0)
[21:30:55.026] Timer tick, asking Buildbucket for the build status
[21:30:55.086] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:55.086] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:47:0) after 1m0s
[21:31:55.102] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:47:0)
[21:31:55.102] Timer tick, asking Buildbucket for the build status
[21:31:55.179] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:55.179] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:48:0) after 1m0s
[21:32:55.201] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:48:0)
[21:32:55.201] Timer tick, asking Buildbucket for the build status
[21:32:55.270] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:55.270] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:49:0) after 1m0s
[21:33:55.294] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:49:0)
[21:33:55.294] Timer tick, asking Buildbucket for the build status
[21:33:55.368] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:55.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:50:0) after 1m0s
[21:34:55.387] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:50:0)
[21:34:55.387] Timer tick, asking Buildbucket for the build status
[21:34:55.473] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:55.473] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:51:0) after 1m0s
[21:35:55.494] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:51:0)
[21:35:55.494] Timer tick, asking Buildbucket for the build status
[21:35:55.606] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:55.606] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:52:0) after 1m0s
[21:36:55.632] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:52:0)
[21:36:55.632] Timer tick, asking Buildbucket for the build status
[21:36:55.717] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:55.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:53:0) after 1m0s
[21:37:55.734] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:53:0)
[21:37:55.734] Timer tick, asking Buildbucket for the build status
[21:37:55.799] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:55.799] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:54:0) after 1m0s
[21:38:55.816] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:54:0)
[21:38:55.816] Timer tick, asking Buildbucket for the build status
[21:38:55.962] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:55.962] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:55:0) after 1m0s
[21:39:56.004] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:55:0)
[21:39:56.004] Timer tick, asking Buildbucket for the build status
[21:39:56.373] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:56.373] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:56:0) after 1m0s
[21:40:56.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:56:0)
[21:40:56.398] Timer tick, asking Buildbucket for the build status
[21:40:56.465] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:56.465] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:57:0) after 1m0s
[21:41:56.487] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:57:0)
[21:41:56.487] Timer tick, asking Buildbucket for the build status
[21:41:56.712] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:56.712] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:58:0) after 1m0s
[21:42:56.747] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:58:0)
[21:42:56.747] Timer tick, asking Buildbucket for the build status
[21:42:56.936] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:56.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:59:0) after 1m0s
[21:43:56.954] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:59:0)
[21:43:56.954] Timer tick, asking Buildbucket for the build status
[21:43:57.024] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:57.024] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:60:0) after 1m0s
[21:44:57.128] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:60:0)
[21:44:57.128] Timer tick, asking Buildbucket for the build status
[21:44:57.392] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:57.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:61:0) after 1m0s
[21:45:57.420] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:61:0)
[21:45:57.420] Timer tick, asking Buildbucket for the build status
[21:45:57.796] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:57.838] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:62:0) after 1m0s
[21:46:57.871] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:62:0)
[21:46:57.871] Timer tick, asking Buildbucket for the build status
[21:46:58.312] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:58.312] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:63:0) after 1m0s
[21:47:58.330] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:63:0)
[21:47:58.330] Timer tick, asking Buildbucket for the build status
[21:47:58.505] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:58.505] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:64:0) after 1m0s
[21:48:58.524] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:64:0)
[21:48:58.524] Timer tick, asking Buildbucket for the build status
[21:48:58.686] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:58.686] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:65:0) after 1m0s
[21:49:58.704] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:65:0)
[21:49:58.704] Timer tick, asking Buildbucket for the build status
[21:49:58.943] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:58.943] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:66:0) after 1m0s
[21:50:58.970] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:66:0)
[21:50:58.970] Timer tick, asking Buildbucket for the build status
[21:50:59.090] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:59.090] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:67:0) after 1m0s
[21:51:59.111] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:67:0)
[21:51:59.111] Timer tick, asking Buildbucket for the build status
[21:51:59.480] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:59.480] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:68:0) after 1m0s
[21:52:59.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:68:0)
[21:52:59.557] Timer tick, asking Buildbucket for the build status
[21:52:59.659] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:59.659] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:69:0) after 1m0s
[21:53:59.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:69:0)
[21:53:59.679] Timer tick, asking Buildbucket for the build status
[21:54:00.030] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:00.030] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:70:0) after 1m0s
[21:55:00.058] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:70:0)
[21:55:00.058] Timer tick, asking Buildbucket for the build status
[21:55:00.179] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:00.179] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:71:0) after 1m0s
[21:56:00.198] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:71:0)
[21:56:00.198] Timer tick, asking Buildbucket for the build status
[21:56:00.296] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:00.296] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:72:0) after 1m0s
[21:57:00.314] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:72:0)
[21:57:00.314] Timer tick, asking Buildbucket for the build status
[21:57:00.373] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:00.373] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:73:0) after 1m0s
[21:58:00.401] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:73:0)
[21:58:00.401] Timer tick, asking Buildbucket for the build status
[21:58:00.528] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:00.528] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:74:0) after 1m0s
[21:59:00.546] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:74:0)
[21:59:00.546] Timer tick, asking Buildbucket for the build status
[21:59:00.718] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:00.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:75:0) after 1m0s
[22:00:00.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:75:0)
[22:00:00.759] Timer tick, asking Buildbucket for the build status
[22:00:00.899] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:00.899] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:76:0) after 1m0s
[22:01:00.928] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:76:0)
[22:01:00.928] Timer tick, asking Buildbucket for the build status
[22:01:00.993] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:00.993] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:77:0) after 1m0s
[22:02:01.014] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:77:0)
[22:02:01.014] Timer tick, asking Buildbucket for the build status
[22:02:01.077] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:01.077] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:78:0) after 1m0s
[22:03:01.138] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:78:0)
[22:03:01.138] Timer tick, asking Buildbucket for the build status
[22:03:01.238] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:01.238] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:79:0) after 1m0s
[22:04:01.260] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:79:0)
[22:04:01.260] Timer tick, asking Buildbucket for the build status
[22:04:01.388] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:01.388] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:80:0) after 1m0s
[22:05:01.405] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:80:0)
[22:05:01.405] Timer tick, asking Buildbucket for the build status
[22:05:01.492] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:01.492] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:81:0) after 1m0s
[22:06:01.510] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:81:0)
[22:06:01.510] Timer tick, asking Buildbucket for the build status
[22:06:04.917] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:04.917] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:82:0) after 1m0s
[22:07:04.949] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:82:0)
[22:07:04.949] Timer tick, asking Buildbucket for the build status
[22:07:05.056] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:05.056] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:83:0) after 1m0s
[22:08:05.084] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:83:0)
[22:08:05.084] Timer tick, asking Buildbucket for the build status
[22:08:05.300] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:05.300] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:84:0) after 1m0s
[22:09:05.321] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:84:0)
[22:09:05.321] Timer tick, asking Buildbucket for the build status
[22:09:05.405] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:05.405] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:85:0) after 1m0s
[22:10:05.423] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:85:0)
[22:10:05.423] Timer tick, asking Buildbucket for the build status
[22:10:05.488] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:05.488] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:86:0) after 1m0s
[22:11:05.517] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:86:0)
[22:11:05.517] Timer tick, asking Buildbucket for the build status
[22:11:05.909] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:05.909] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:87:0) after 1m0s
[22:12:05.928] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:87:0)
[22:12:05.928] Timer tick, asking Buildbucket for the build status
[22:12:05.989] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:05.989] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:88:0) after 1m0s
[22:13:06.012] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:88:0)
[22:13:06.012] Timer tick, asking Buildbucket for the build status
[22:13:06.185] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:06.185] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:89:0) after 1m0s
[22:14:06.294] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:89:0)
[22:14:06.294] Timer tick, asking Buildbucket for the build status
[22:14:06.397] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:06.397] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:90:0) after 1m0s
[22:15:06.429] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:90:0)
[22:15:06.429] Timer tick, asking Buildbucket for the build status
[22:15:06.491] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:06.491] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:91:0) after 1m0s
[22:16:06.508] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:91:0)
[22:16:06.508] Timer tick, asking Buildbucket for the build status
[22:16:06.648] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:06.648] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:92:0) after 1m0s
[22:17:06.683] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:92:0)
[22:17:06.683] Timer tick, asking Buildbucket for the build status
[22:17:06.734] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:06.734] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:93:0) after 1m0s
[22:18:06.752] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:93:0)
[22:18:06.752] Timer tick, asking Buildbucket for the build status
[22:18:06.810] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:06.810] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:94:0) after 1m0s
[22:19:06.830] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:94:0)
[22:19:06.830] Timer tick, asking Buildbucket for the build status
[22:19:06.881] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:06.881] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:95:0) after 1m0s
[22:20:06.902] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:95:0)
[22:20:06.902] Timer tick, asking Buildbucket for the build status
[22:20:06.943] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:06.943] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:96:0) after 1m0s
[22:21:06.974] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:96:0)
[22:21:06.974] Timer tick, asking Buildbucket for the build status
[22:21:07.078] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:07.078] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:97:0) after 1m0s
[22:22:07.190] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:97:0)
[22:22:07.190] Timer tick, asking Buildbucket for the build status
[22:22:07.329] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:07.329] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:98:0) after 1m0s
[22:23:07.429] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:98:0)
[22:23:07.429] Timer tick, asking Buildbucket for the build status
[22:23:07.500] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:07.500] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:99:0) after 1m0s
[22:24:07.524] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:99:0)
[22:24:07.524] Timer tick, asking Buildbucket for the build status
[22:24:07.597] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:07.597] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:100:0) after 1m0s
[22:25:07.642] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:100:0)
[22:25:07.642] Timer tick, asking Buildbucket for the build status
[22:25:07.898] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:07.898] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:101:0) after 1m0s
[22:26:08.102] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:101:0)
[22:26:08.102] Timer tick, asking Buildbucket for the build status
[22:26:08.199] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:08.199] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:102:0) after 1m0s
[22:27:08.350] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:102:0)
[22:27:08.350] Timer tick, asking Buildbucket for the build status
[22:27:08.489] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:08.489] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:103:0) after 1m0s
[22:28:08.541] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:103:0)
[22:28:08.541] Timer tick, asking Buildbucket for the build status
[22:28:08.660] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:08.660] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:104:0) after 1m0s
[22:29:08.743] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:104:0)
[22:29:08.743] Timer tick, asking Buildbucket for the build status
[22:29:08.826] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:08.826] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:105:0) after 1m0s
[22:30:08.871] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:105:0)
[22:30:08.871] Timer tick, asking Buildbucket for the build status
[22:30:09.005] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:09.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:106:0) after 1m0s
[22:31:09.138] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:106:0)
[22:31:09.138] Timer tick, asking Buildbucket for the build status
[22:31:09.194] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:09.194] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:107:0) after 1m0s
[22:32:09.278] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:107:0)
[22:32:09.278] Timer tick, asking Buildbucket for the build status
[22:32:09.412] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:09.412] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:108:0) after 1m0s
[22:33:09.433] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:108:0)
[22:33:09.433] Timer tick, asking Buildbucket for the build status
[22:33:09.569] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:09.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:109:0) after 1m0s
[22:34:09.626] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:109:0)
[22:34:09.626] Timer tick, asking Buildbucket for the build status
[22:34:09.691] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:09.691] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:110:0) after 1m0s
[22:35:09.784] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:110:0)
[22:35:09.784] Timer tick, asking Buildbucket for the build status
[22:35:09.851] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:09.851] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:111:0) after 1m0s
[22:36:09.963] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:111:0)
[22:36:09.963] Timer tick, asking Buildbucket for the build status
[22:36:10.025] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:10.025] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:112:0) after 1m0s
[22:37:10.166] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:112:0)
[22:37:10.166] Timer tick, asking Buildbucket for the build status
[22:37:10.317] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:10.317] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:113:0) after 1m0s
[22:38:10.433] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:113:0)
[22:38:10.433] Timer tick, asking Buildbucket for the build status
[22:38:10.624] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:10.624] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:114:0) after 1m0s
[22:39:10.684] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:114:0)
[22:39:10.684] Timer tick, asking Buildbucket for the build status
[22:39:11.338] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:11.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:115:0) after 1m0s
[22:40:11.359] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:115:0)
[22:40:11.359] Timer tick, asking Buildbucket for the build status
[22:40:11.399] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:11.399] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:116:0) after 1m0s
[22:41:11.420] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:116:0)
[22:41:11.420] Timer tick, asking Buildbucket for the build status
[22:41:11.475] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:11.475] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:117:0) after 1m0s
[22:42:11.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:117:0)
[22:42:11.503] Timer tick, asking Buildbucket for the build status
[22:42:11.551] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:11.551] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:118:0) after 1m0s
[22:43:11.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:118:0)
[22:43:11.656] Timer tick, asking Buildbucket for the build status
[22:43:12.083] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:12.083] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:119:0) after 1m0s
[22:44:12.104] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:119:0)
[22:44:12.104] Timer tick, asking Buildbucket for the build status
[22:44:12.168] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:12.168] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:120:0) after 1m0s
[22:45:12.314] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:120:0)
[22:45:12.314] Timer tick, asking Buildbucket for the build status
[22:45:12.429] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:12.429] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:121:0) after 1m0s
[22:46:12.523] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:121:0)
[22:46:12.523] Timer tick, asking Buildbucket for the build status
[22:46:12.589] Build 8945976284596902112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:12.589] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android:9111406347611716080:122:0) after 1m0s
[22:46:48.114] Received PubSub notification, asking Buildbucket for the build status
[22:46:48.187] Build 8945976284596902112: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:46:48.187] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1526856407081640",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1526849204408210",
"experimental": true,
"id": "8945976284596902112",
"parameters_json": "{\"builder_name\": \"Deterministic Android\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"2d201b10f2b2b104928993f680ad2b02d1ca0cdb\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"task_result\": {\"cipd_pins\": {\"packages\": [{\"path\": \".\", \"version\": \"e4b90cad477c47ea00ff4dbd6183667bb0f1a82c\", \"package_name\": \"infra/tools/luci/kitchen/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"c7fd5d2f9d9f0ea85454eb32690f41ef1d29c749\", \"package_name\": \"infra/git/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"46c0c897ca0f053799ee41fd148bb7a47232df47\", \"package_name\": \"infra/python/cpython/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"6e5ff69bbe48c38117c44fd735cb7adb32417549\", \"package_name\": \"infra/tools/buildbucket/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"4672ed11a416bb60e9ec6738dab9cc41386971f5\", \"package_name\": \"infra/tools/cloudtail/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"139d6a6663b2cdd9420516c9335d0731dd2c5c58\", \"package_name\": \"infra/tools/git/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"df53a719b65668e3b16ecdb600f29f8c901cd67e\", \"package_name\": \"infra/tools/luci-auth/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"72f5c9ec60e557643b06eac503836fb78359ca06\", \"package_name\": \"infra/tools/luci/git-credential-luci/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"defef80b8231a429bb8b4931798307272a536717\", \"package_name\": \"infra/tools/luci/vpython-native/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"8bf6a502584cb13fdb2bb5dcbc7bbb59a6d983a5\", \"package_name\": \"infra/tools/luci/vpython/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"7ac9ea00b7d1d664e9015d2bbd537bc8cb3bfda4\", \"package_name\": \"infra/tools/prpc/linux-amd64\"}, {\"path\": \"kitchen-checkout\", \"version\": \"ff5fc2c5c3aa6a57b2f519f1f5127b64335bc97e\", \"package_name\": \"infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\"}], \"client_package\": {\"version\": \"e891a48eebcd04fee5b054173539b558cbcc027c\", \"package_name\": \"infra/tools/cipd/linux-amd64\"}}, \"run_id\": \"3d981f7d18dac511\", \"outputs_ref\": {\"isolatedserver\": \"https://isolateserver.appspot.com\", \"namespace\": \"default-gzip\", \"isolated\": \"61edbe7b230b766617c69557e82c592f85ae836d\"}, \"server_versions\": [\"3551-c9816d0\"], \"duration\": 6954.5293478965759, \"completed_ts\": \"2018-05-20T22:46:47.081640\", \"started_ts\": \"2018-05-20T20:47:19.499460\", \"internal_failure\": false, \"exit_code\": \"0\", \"state\": \"COMPLETED\", \"bot_version\": \"57022332981f5283a1712485c1f04cb7c6b22c564bac3a7d32c50ec8eb0b407e\", \"tags\": [\"build_address:luci.chromium.ci/Deterministic Android/1505\", \"buildbucket_bucket:luci.chromium.ci\", \"buildbucket_build_id:8945976284596902112\", \"buildbucket_hostname:cr-buildbucket.appspot.com\", \"buildbucket_template_canary:0\", \"buildbucket_template_revision:06be006c935279af3663102925cce4dcc526e425\", \"builder:Deterministic Android\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2d201b10f2b2b104928993f680ad2b02d1ca0cdb\", \"cores:8\", \"cpu:x86-64\", \"gitiles_ref:refs/heads/master\", \"log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8945976284596902112/+/annotations\", \"luci_project:chromium\", \"pool:luci.chromium.ci\", \"priority:60\", \"recipe_name:swarming/deterministic_build\", \"recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\", \"scheduler_invocation_id:9111406347611716080\", \"scheduler_job_id:chromium/Deterministic Android\", \"service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com\", \"user:None\", \"user_agent:luci-scheduler\", \"vpython:native-python-wrapper\"], \"failure\": false, \"modified_ts\": \"2018-05-20T22:46:47.081640\", \"user\": \"\", \"created_ts\": \"2018-05-20T20:46:45.238670\", \"name\": \"bb-8945976284596902112-chromium-Deterministic Android\", \"task_id\": \"3d981f7d18dac510\", \"bot_dimensions\": [{\"value\": [\"Deterministic Android\"], \"key\": \"builder\"}, {\"value\": [\"builder_0645ad7c3100ce7e979d6500743a77a8639bf9d1270a1208e14cd3b1ff9ed362_v2\", \"git\", \"goma\", \"goma_v2\", \"vpython\"], \"key\": \"caches\"}, {\"value\": [\"8\"], \"key\": \"cores\"}, {\"value\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"key\": \"cpu\"}, {\"value\": [\"none\"], \"key\": \"gpu\"}, {\"value\": [\"swarm628-c4\"], \"key\": \"id\"}, {\"value\": [\"0\"], \"key\": \"inside_docker\"}, {\"value\": [\"1\"], \"key\": \"kvm\"}, {\"value\": [\"n1-standard-8\"], \"key\": \"machine_type\"}, {\"value\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"key\": \"os\"}, {\"value\": [\"luci.chromium.ci\"], \"key\": \"pool\"}, {\"value\": [\"2.7.6\"], \"key\": \"python\"}, {\"value\": [\"3551-c9816d0\"], \"key\": \"server_version\"}, {\"value\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"key\": \"zone\"}], \"try_number\": \"1\", \"current_task_slice\": \"0\", \"costs_usd\": [0.82606501700459556], \"bot_id\": \"swarm628-c4\"}}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"jsonResult\": \"null\"}, \"recipeExitCode\": {\"value\": 0}, \"recipe\": {\"name\": \"swarming/deterministic_build\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8945976284596902112/+/annotations\"}, \"ui\": {\"info\": \"\"}, \"properties\": {\"got_nacl_revision\": \"93deff44b49fcbb4da0ee7961f21b6b93da194e9\", \"got_swarming_client_revision\": \"833f5ebf894be1e3e6d13678d5de8479bf12ff28\", \"got_revision\": \"2d201b10f2b2b104928993f680ad2b02d1ca0cdb\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#23315}\", \"$build/goma\": {\"jobs\": 150}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"got_src_revision_cp\": \"refs/heads/master@{#560202}\", \"buildername\": \"Deterministic Android\", \"got_revision_cp\": \"refs/heads/master@{#560202}\", \"branch\": \"refs/heads/master\", \"revision\": \"2d201b10f2b2b104928993f680ad2b02d1ca0cdb\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"got_src_revision\": \"2d201b10f2b2b104928993f680ad2b02d1ca0cdb\", \"got_webrtc_revision\": \"a832019f4e3ac11544f1497368a16a3a525e2932\", \"mastername\": \"chromium.android\", \"$recipe_engine/runtime\": {\"is_experimental\": true, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1526849204408210, \"tags\": [\"builder:Deterministic Android\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2d201b10f2b2b104928993f680ad2b02d1ca0cdb\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9111406347611716080\", \"scheduler_job_id:chromium/Deterministic Android\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.chromium.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"chromium\", \"id\": \"8945976284596902112\"}}, \"got_v8_revision\": \"41a6376dfc7f887b6368ff8521f2bdfa41a0bf5b\", \"got_v8_revision_cp\": \"refs/heads/6.8.261@{#1}\", \"got_angle_revision\": \"42cf958ce8fa5894ff6099106e19e90422386123\", \"buildnumber\": 1505, \"path_config\": \"generic\", \"got_buildtools_revision\": \"94288c26d2ffe3aec9848c147839afee597acefd\", \"bot_id\": \"swarm628-c4\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1526849239499460",
"status": "COMPLETED",
"status_changed_ts": "1526856407649240",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android/1505",
"builder:Deterministic Android",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2d201b10f2b2b104928993f680ad2b02d1ca0cdb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9111406347611716080",
"scheduler_job_id:chromium/Deterministic Android",
"swarming_dimension:builder:Deterministic Android",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Deterministic Android/1505",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8945976284596902112",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:06be006c935279af3663102925cce4dcc526e425",
"swarming_tag:builder:Deterministic Android",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2d201b10f2b2b104928993f680ad2b02d1ca0cdb",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8945976284596902112/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:60",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9111406347611716080",
"swarming_tag:scheduler_job_id:chromium/Deterministic Android",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3d981f7d18dac510",
"user_agent:luci-scheduler"
],
"updated_ts": "1526856407650710",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Deterministic Android/1505",
"utcnow_ts": "1526856408142130"
}
}
[22:46:48.187] Invocation finished in 2h0m6.038318166s with status SUCCEEDED