[00:06:26.494] New invocation is queued and will start shortly
[00:06:27.671] Starting the invocation (attempt 1)
[00:06:27.738] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:06:27.738] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:06:27.738] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9089106927397825856",
"parameters_json": "{\"builder_name\":\"Deterministic Android (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"b2225c8da4715c5ccc49cf54880c12afbe2d2638\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Android (dbg)",
"scheduler_invocation_id:9089106927397825856",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/b2225c8da4715c5ccc49cf54880c12afbe2d2638",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b2225c8da4715c5ccc49cf54880c12afbe2d2638",
"gitiles_ref:refs/heads/master"
]
}
[00:06:30.319] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1548115587878460",
"experimental": true,
"id": "8923676865283178800",
"lease_expiration_ts": "1548234389772512",
"lease_key": "219566192",
"parameters_json": "{\"builder_name\": \"Deterministic Android (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b2225c8da4715c5ccc49cf54880c12afbe2d2638\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1548115590099853",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android (dbg)/3567",
"builder:Deterministic Android (dbg)",
"buildset:commit/git/b2225c8da4715c5ccc49cf54880c12afbe2d2638",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b2225c8da4715c5ccc49cf54880c12afbe2d2638",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9089106927397825856",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_dimension:builder:Deterministic Android (dbg)",
"swarming_dimension:caches:builder_2bff2df219af63c0787c4be2031d3fbd218ec1b0853f1b8ce80b2331f0e04ffd_v2",
"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 (dbg)/3567",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8923676865283178800",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
"swarming_tag:builder:Deterministic Android (dbg)",
"swarming_tag:buildset:commit/git/b2225c8da4715c5ccc49cf54880c12afbe2d2638",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b2225c8da4715c5ccc49cf54880c12afbe2d2638",
"swarming_tag:caches:builder_2bff2df219af63c0787c4be2031d3fbd218ec1b0853f1b8ce80b2331f0e04ffd_v2",
"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/8923676865283178800/+/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:9089106927397825856",
"swarming_tag:scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:4122e711faf74a549260c6de6a369a8fe79a9d3e",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:428bb2c0006ec010",
"user_agent:luci-scheduler"
],
"updated_ts": "1548115590099957",
"url": "https://ci.chromium.org/b/8923676865283178800",
"utcnow_ts": "1548115590301771"
}
}
[00:06:30.319] Task URL: https://ci.chromium.org/b/8923676865283178800
[00:06:30.319] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:2:0) after 1m0s
[00:06:33.170] Received PubSub notification, asking Buildbucket for the build status
[00:06:33.203] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:30.333] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:2:0)
[00:07:30.333] Timer tick, asking Buildbucket for the build status
[00:07:30.406] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:30.406] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:4:0) after 1m0s
[00:08:30.422] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:4:0)
[00:08:30.422] Timer tick, asking Buildbucket for the build status
[00:08:30.548] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:30.548] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:5:0) after 1m0s
[00:09:30.661] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:5:0)
[00:09:30.661] Timer tick, asking Buildbucket for the build status
[00:09:30.742] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:30.742] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:6:0) after 1m0s
[00:10:30.758] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:6:0)
[00:10:30.758] Timer tick, asking Buildbucket for the build status
[00:10:30.824] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:30.824] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:7:0) after 1m0s
[00:11:30.839] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:7:0)
[00:11:30.839] Timer tick, asking Buildbucket for the build status
[00:11:30.923] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:30.923] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:8:0) after 1m0s
[00:12:30.941] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:8:0)
[00:12:30.941] Timer tick, asking Buildbucket for the build status
[00:12:31.003] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:31.003] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:9:0) after 1m0s
[00:13:31.018] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:9:0)
[00:13:31.018] Timer tick, asking Buildbucket for the build status
[00:13:31.272] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:31.272] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:10:0) after 1m0s
[00:14:31.291] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:10:0)
[00:14:31.291] Timer tick, asking Buildbucket for the build status
[00:14:31.357] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:31.357] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:11:0) after 1m0s
[00:15:31.373] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:11:0)
[00:15:31.373] Timer tick, asking Buildbucket for the build status
[00:15:31.642] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:31.642] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:12:0) after 1m0s
[00:16:31.657] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:12:0)
[00:16:31.657] Timer tick, asking Buildbucket for the build status
[00:16:31.718] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:31.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:13:0) after 1m0s
[00:17:31.732] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:13:0)
[00:17:31.732] Timer tick, asking Buildbucket for the build status
[00:17:31.825] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:31.825] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:14:0) after 1m0s
[00:18:31.841] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:14:0)
[00:18:31.841] Timer tick, asking Buildbucket for the build status
[00:18:31.880] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:31.880] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:15:0) after 1m0s
[00:19:31.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:15:0)
[00:19:31.908] Timer tick, asking Buildbucket for the build status
[00:19:32.133] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:32.133] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:16:0) after 1m0s
[00:20:32.155] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:16:0)
[00:20:32.155] Timer tick, asking Buildbucket for the build status
[00:20:32.337] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:32.337] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:17:0) after 1m0s
[00:21:32.353] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:17:0)
[00:21:32.353] Timer tick, asking Buildbucket for the build status
[00:21:32.422] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:32.422] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:18:0) after 1m0s
[00:22:32.442] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:18:0)
[00:22:32.442] Timer tick, asking Buildbucket for the build status
[00:22:32.481] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:32.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:19:0) after 1m0s
[00:23:32.495] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:19:0)
[00:23:32.495] Timer tick, asking Buildbucket for the build status
[00:23:32.685] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:32.685] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:20:0) after 1m0s
[00:24:32.699] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:20:0)
[00:24:32.699] Timer tick, asking Buildbucket for the build status
[00:24:32.730] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:32.730] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:21:0) after 1m0s
[00:25:32.747] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:21:0)
[00:25:32.747] Timer tick, asking Buildbucket for the build status
[00:25:32.803] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:32.803] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:22:0) after 1m0s
[00:26:32.825] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:22:0)
[00:26:32.825] Timer tick, asking Buildbucket for the build status
[00:26:32.896] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:32.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:23:0) after 1m0s
[00:27:32.927] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:23:0)
[00:27:32.928] Timer tick, asking Buildbucket for the build status
[00:27:33.099] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:33.099] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:24:0) after 1m0s
[00:28:33.149] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:24:0)
[00:28:33.149] Timer tick, asking Buildbucket for the build status
[00:28:33.196] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:33.196] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:25:0) after 1m0s
[00:29:33.212] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:25:0)
[00:29:33.212] Timer tick, asking Buildbucket for the build status
[00:29:33.524] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:33.524] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:26:0) after 1m0s
[00:30:33.546] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:26:0)
[00:30:33.546] Timer tick, asking Buildbucket for the build status
[00:30:33.605] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:33.605] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:27:0) after 1m0s
[00:31:33.756] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:27:0)
[00:31:33.757] Timer tick, asking Buildbucket for the build status
[00:31:33.798] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:33.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:28:0) after 1m0s
[00:32:33.814] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:28:0)
[00:32:33.814] Timer tick, asking Buildbucket for the build status
[00:32:33.870] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:33.870] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:29:0) after 1m0s
[00:33:33.890] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:29:0)
[00:33:33.890] Timer tick, asking Buildbucket for the build status
[00:33:33.944] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:33.944] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:30:0) after 1m0s
[00:34:33.983] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:30:0)
[00:34:33.983] Timer tick, asking Buildbucket for the build status
[00:34:34.092] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:34.092] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:31:0) after 1m0s
[00:35:34.112] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:31:0)
[00:35:34.112] Timer tick, asking Buildbucket for the build status
[00:35:34.368] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:34.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:32:0) after 1m0s
[00:36:34.382] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:32:0)
[00:36:34.382] Timer tick, asking Buildbucket for the build status
[00:36:34.446] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:34.446] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:33:0) after 1m0s
[00:37:34.467] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:33:0)
[00:37:34.467] Timer tick, asking Buildbucket for the build status
[00:37:34.517] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:34.517] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:34:0) after 1m0s
[00:38:34.545] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:34:0)
[00:38:34.545] Timer tick, asking Buildbucket for the build status
[00:38:34.659] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:34.659] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:35:0) after 1m0s
[00:39:34.677] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:35:0)
[00:39:34.677] Timer tick, asking Buildbucket for the build status
[00:39:34.738] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:34.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:36:0) after 1m0s
[00:40:34.795] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:36:0)
[00:40:34.795] Timer tick, asking Buildbucket for the build status
[00:40:34.960] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:34.960] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:37:0) after 1m0s
[00:41:35.032] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:37:0)
[00:41:35.032] Timer tick, asking Buildbucket for the build status
[00:41:35.153] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:35.153] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:38:0) after 1m0s
[00:42:35.184] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:38:0)
[00:42:35.184] Timer tick, asking Buildbucket for the build status
[00:42:35.219] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:35.219] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:39:0) after 1m0s
[00:43:35.236] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:39:0)
[00:43:35.236] Timer tick, asking Buildbucket for the build status
[00:43:35.277] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:35.277] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:40:0) after 1m0s
[00:44:35.294] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:40:0)
[00:44:35.294] Timer tick, asking Buildbucket for the build status
[00:44:35.369] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:35.369] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:41:0) after 1m0s
[00:45:35.385] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:41:0)
[00:45:35.385] Timer tick, asking Buildbucket for the build status
[00:45:36.007] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:36.007] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:42:0) after 1m0s
[00:46:36.030] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:42:0)
[00:46:36.030] Timer tick, asking Buildbucket for the build status
[00:46:36.065] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:36.065] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:43:0) after 1m0s
[00:47:36.094] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:43:0)
[00:47:36.094] Timer tick, asking Buildbucket for the build status
[00:47:36.174] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:36.174] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:44:0) after 1m0s
[00:48:36.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:44:0)
[00:48:36.192] Timer tick, asking Buildbucket for the build status
[00:48:36.441] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:36.441] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:45:0) after 1m0s
[00:49:36.433] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:45:0)
[00:49:36.433] Timer tick, asking Buildbucket for the build status
[00:49:36.508] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:36.508] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:46:0) after 1m0s
[00:50:36.530] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:46:0)
[00:50:36.530] Timer tick, asking Buildbucket for the build status
[00:50:36.565] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:36.565] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:47:0) after 1m0s
[00:51:36.585] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:47:0)
[00:51:36.585] Timer tick, asking Buildbucket for the build status
[00:51:36.641] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:36.641] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:48:0) after 1m0s
[00:52:36.660] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:48:0)
[00:52:36.660] Timer tick, asking Buildbucket for the build status
[00:52:36.805] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:36.805] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:49:0) after 1m0s
[00:53:36.822] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:49:0)
[00:53:36.822] Timer tick, asking Buildbucket for the build status
[00:53:36.861] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:36.861] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:50:0) after 1m0s
[00:54:36.876] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:50:0)
[00:54:36.877] Timer tick, asking Buildbucket for the build status
[00:54:36.934] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:36.934] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:51:0) after 1m0s
[00:55:36.951] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:51:0)
[00:55:36.951] Timer tick, asking Buildbucket for the build status
[00:55:38.151] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:38.151] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:52:0) after 1m0s
[00:56:38.166] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:52:0)
[00:56:38.166] Timer tick, asking Buildbucket for the build status
[00:56:38.226] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:38.226] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:53:0) after 1m0s
[00:57:38.320] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:53:0)
[00:57:38.320] Timer tick, asking Buildbucket for the build status
[00:57:38.418] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:38.418] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:54:0) after 1m0s
[00:58:38.435] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:54:0)
[00:58:38.435] Timer tick, asking Buildbucket for the build status
[00:58:38.618] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:38.618] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:55:0) after 1m0s
[00:59:38.634] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:55:0)
[00:59:38.634] Timer tick, asking Buildbucket for the build status
[00:59:38.688] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:38.688] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:56:0) after 1m0s
[01:00:38.705] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:56:0)
[01:00:38.705] Timer tick, asking Buildbucket for the build status
[01:00:38.840] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:38.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:57:0) after 1m0s
[01:01:38.857] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:57:0)
[01:01:38.857] Timer tick, asking Buildbucket for the build status
[01:01:39.080] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:39.080] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:58:0) after 1m0s
[01:02:39.096] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:58:0)
[01:02:39.096] Timer tick, asking Buildbucket for the build status
[01:02:39.180] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:39.180] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:59:0) after 1m0s
[01:03:39.201] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:59:0)
[01:03:39.201] Timer tick, asking Buildbucket for the build status
[01:03:39.269] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:39.269] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:60:0) after 1m0s
[01:04:39.286] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:60:0)
[01:04:39.286] Timer tick, asking Buildbucket for the build status
[01:04:39.355] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:39.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:61:0) after 1m0s
[01:05:39.372] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:61:0)
[01:05:39.372] Timer tick, asking Buildbucket for the build status
[01:05:39.427] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:39.427] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:62:0) after 1m0s
[01:06:39.445] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:62:0)
[01:06:39.445] Timer tick, asking Buildbucket for the build status
[01:06:39.504] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:39.504] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:63:0) after 1m0s
[01:07:39.525] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:63:0)
[01:07:39.525] Timer tick, asking Buildbucket for the build status
[01:07:39.659] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:39.659] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:64:0) after 1m0s
[01:08:39.703] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:64:0)
[01:08:39.703] Timer tick, asking Buildbucket for the build status
[01:08:39.762] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:39.762] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:65:0) after 1m0s
[01:09:39.838] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:65:0)
[01:09:39.838] Timer tick, asking Buildbucket for the build status
[01:09:40.039] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:40.039] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:66:0) after 1m0s
[01:10:40.056] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:66:0)
[01:10:40.056] Timer tick, asking Buildbucket for the build status
[01:10:40.101] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:40.101] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:67:0) after 1m0s
[01:11:40.134] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:67:0)
[01:11:40.134] Timer tick, asking Buildbucket for the build status
[01:11:40.217] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:40.217] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:68:0) after 1m0s
[01:12:40.247] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:68:0)
[01:12:40.247] Timer tick, asking Buildbucket for the build status
[01:12:40.335] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:40.335] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:69:0) after 1m0s
[01:13:40.355] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:69:0)
[01:13:40.355] Timer tick, asking Buildbucket for the build status
[01:13:40.426] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:40.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:70:0) after 1m0s
[01:14:40.462] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:70:0)
[01:14:40.462] Timer tick, asking Buildbucket for the build status
[01:14:40.531] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:40.531] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:71:0) after 1m0s
[01:15:40.556] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:71:0)
[01:15:40.556] Timer tick, asking Buildbucket for the build status
[01:15:40.702] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:40.702] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:72:0) after 1m0s
[01:16:40.721] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:72:0)
[01:16:40.721] Timer tick, asking Buildbucket for the build status
[01:16:40.828] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:40.828] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:73:0) after 1m0s
[01:17:40.845] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:73:0)
[01:17:40.845] Timer tick, asking Buildbucket for the build status
[01:17:40.905] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:40.905] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:74:0) after 1m0s
[01:18:40.907] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:74:0)
[01:18:40.907] Timer tick, asking Buildbucket for the build status
[01:18:41.166] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:41.166] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:75:0) after 1m0s
[01:19:41.185] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:75:0)
[01:19:41.185] Timer tick, asking Buildbucket for the build status
[01:19:41.218] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:41.218] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:76:0) after 1m0s
[01:20:41.237] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:76:0)
[01:20:41.237] Timer tick, asking Buildbucket for the build status
[01:20:41.302] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:41.302] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:77:0) after 1m0s
[01:21:41.321] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:77:0)
[01:21:41.322] Timer tick, asking Buildbucket for the build status
[01:21:41.434] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:41.434] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:78:0) after 1m0s
[01:22:41.462] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:78:0)
[01:22:41.462] Timer tick, asking Buildbucket for the build status
[01:22:41.528] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:41.528] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:79:0) after 1m0s
[01:23:41.547] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:79:0)
[01:23:41.547] Timer tick, asking Buildbucket for the build status
[01:23:41.581] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:41.581] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:80:0) after 1m0s
[01:24:41.600] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:80:0)
[01:24:41.600] Timer tick, asking Buildbucket for the build status
[01:24:41.655] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:41.655] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:81:0) after 1m0s
[01:25:41.674] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:81:0)
[01:25:41.674] Timer tick, asking Buildbucket for the build status
[01:25:41.730] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:41.730] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:82:0) after 1m0s
[01:26:41.749] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:82:0)
[01:26:41.749] Timer tick, asking Buildbucket for the build status
[01:26:41.809] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:41.809] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:83:0) after 1m0s
[01:27:41.847] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:83:0)
[01:27:41.847] Timer tick, asking Buildbucket for the build status
[01:27:41.920] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:41.920] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:84:0) after 1m0s
[01:28:41.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:84:0)
[01:28:41.950] Timer tick, asking Buildbucket for the build status
[01:28:42.059] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:42.059] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:85:0) after 1m0s
[01:29:42.083] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:85:0)
[01:29:42.083] Timer tick, asking Buildbucket for the build status
[01:29:42.153] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:42.153] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:86:0) after 1m0s
[01:30:42.196] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:86:0)
[01:30:42.196] Timer tick, asking Buildbucket for the build status
[01:30:42.374] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:42.374] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:87:0) after 1m0s
[01:31:42.396] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:87:0)
[01:31:42.396] Timer tick, asking Buildbucket for the build status
[01:31:42.524] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:42.524] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:88:0) after 1m0s
[01:32:42.544] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:88:0)
[01:32:42.544] Timer tick, asking Buildbucket for the build status
[01:32:42.582] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:42.582] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:89:0) after 1m0s
[01:33:42.600] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:89:0)
[01:33:42.600] Timer tick, asking Buildbucket for the build status
[01:33:42.700] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:42.700] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:90:0) after 1m0s
[01:34:42.725] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:90:0)
[01:34:42.725] Timer tick, asking Buildbucket for the build status
[01:34:42.857] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:42.857] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:91:0) after 1m0s
[01:35:42.940] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:91:0)
[01:35:42.940] Timer tick, asking Buildbucket for the build status
[01:35:43.075] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:43.075] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:92:0) after 1m0s
[01:36:43.097] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:92:0)
[01:36:43.097] Timer tick, asking Buildbucket for the build status
[01:36:43.240] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:43.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:93:0) after 1m0s
[01:37:43.260] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:93:0)
[01:37:43.260] Timer tick, asking Buildbucket for the build status
[01:37:43.365] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:43.365] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:94:0) after 1m0s
[01:38:43.384] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:94:0)
[01:38:43.384] Timer tick, asking Buildbucket for the build status
[01:38:43.439] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:43.439] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:95:0) after 1m0s
[01:39:43.458] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:95:0)
[01:39:43.458] Timer tick, asking Buildbucket for the build status
[01:39:43.550] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:43.550] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:96:0) after 1m0s
[01:40:43.566] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:96:0)
[01:40:43.566] Timer tick, asking Buildbucket for the build status
[01:40:43.655] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:43.655] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:97:0) after 1m0s
[01:41:43.699] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:97:0)
[01:41:43.699] Timer tick, asking Buildbucket for the build status
[01:41:43.770] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:43.770] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:98:0) after 1m0s
[01:42:43.793] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:98:0)
[01:42:43.793] Timer tick, asking Buildbucket for the build status
[01:42:43.861] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:43.861] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:99:0) after 1m0s
[01:43:43.883] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:99:0)
[01:43:43.883] Timer tick, asking Buildbucket for the build status
[01:43:43.960] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:43.960] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:100:0) after 1m0s
[01:44:44.025] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:100:0)
[01:44:44.025] Timer tick, asking Buildbucket for the build status
[01:44:44.092] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:44.092] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:101:0) after 1m0s
[01:45:44.114] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:101:0)
[01:45:44.115] Timer tick, asking Buildbucket for the build status
[01:45:44.197] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:44.197] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:102:0) after 1m0s
[01:46:44.238] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:102:0)
[01:46:44.238] Timer tick, asking Buildbucket for the build status
[01:46:44.430] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:44.430] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:103:0) after 1m0s
[01:47:44.457] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:103:0)
[01:47:44.457] Timer tick, asking Buildbucket for the build status
[01:47:44.526] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:44.526] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:104:0) after 1m0s
[01:48:44.547] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:104:0)
[01:48:44.548] Timer tick, asking Buildbucket for the build status
[01:48:44.645] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:44.645] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:105:0) after 1m0s
[01:49:44.675] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:105:0)
[01:49:44.675] Timer tick, asking Buildbucket for the build status
[01:49:44.735] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:44.735] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:106:0) after 1m0s
[01:50:44.756] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:106:0)
[01:50:44.756] Timer tick, asking Buildbucket for the build status
[01:50:45.104] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:45.104] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:107:0) after 1m0s
[01:51:45.126] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:107:0)
[01:51:45.126] Timer tick, asking Buildbucket for the build status
[01:51:45.194] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:45.194] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:108:0) after 1m0s
[01:52:45.213] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:108:0)
[01:52:45.213] Timer tick, asking Buildbucket for the build status
[01:52:45.332] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:45.332] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:109:0) after 1m0s
[01:53:45.352] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:109:0)
[01:53:45.352] Timer tick, asking Buildbucket for the build status
[01:53:45.437] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:45.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:110:0) after 1m0s
[01:54:45.460] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:110:0)
[01:54:45.460] Timer tick, asking Buildbucket for the build status
[01:54:45.524] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:45.524] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:111:0) after 1m0s
[01:55:45.638] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:111:0)
[01:55:45.638] Timer tick, asking Buildbucket for the build status
[01:55:45.693] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:45.693] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:112:0) after 1m0s
[01:56:45.762] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:112:0)
[01:56:45.762] Timer tick, asking Buildbucket for the build status
[01:56:45.798] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:45.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:113:0) after 1m0s
[01:57:45.860] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:113:0)
[01:57:45.860] Timer tick, asking Buildbucket for the build status
[01:57:45.917] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:45.917] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:114:0) after 1m0s
[01:58:45.959] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:114:0)
[01:58:45.959] Timer tick, asking Buildbucket for the build status
[01:58:46.022] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:46.022] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:115:0) after 1m0s
[01:59:46.049] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:115:0)
[01:59:46.049] Timer tick, asking Buildbucket for the build status
[01:59:46.118] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:46.118] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:116:0) after 1m0s
[02:00:46.142] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:116:0)
[02:00:46.142] Timer tick, asking Buildbucket for the build status
[02:00:46.402] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:46.402] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:117:0) after 1m0s
[02:01:46.431] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:117:0)
[02:01:46.431] Timer tick, asking Buildbucket for the build status
[02:01:46.498] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:46.498] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:118:0) after 1m0s
[02:02:46.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:118:0)
[02:02:46.617] Timer tick, asking Buildbucket for the build status
[02:02:46.669] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:46.669] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:119:0) after 1m0s
[02:03:46.707] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:119:0)
[02:03:46.707] Timer tick, asking Buildbucket for the build status
[02:03:46.826] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:46.826] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:120:0) after 1m0s
[02:04:46.846] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:120:0)
[02:04:46.846] Timer tick, asking Buildbucket for the build status
[02:04:46.900] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:46.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:121:0) after 1m0s
[02:05:46.932] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:121:0)
[02:05:46.932] Timer tick, asking Buildbucket for the build status
[02:05:46.994] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:46.994] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:122:0) after 1m0s
[02:06:47.017] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:122:0)
[02:06:47.017] Timer tick, asking Buildbucket for the build status
[02:06:47.099] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:47.099] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:123:0) after 1m0s
[02:07:47.118] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:123:0)
[02:07:47.118] Timer tick, asking Buildbucket for the build status
[02:07:47.171] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:47.171] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:124:0) after 1m0s
[02:08:47.194] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:124:0)
[02:08:47.194] Timer tick, asking Buildbucket for the build status
[02:08:47.257] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:47.257] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:125:0) after 1m0s
[02:09:47.280] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:125:0)
[02:09:47.280] Timer tick, asking Buildbucket for the build status
[02:09:47.354] Build 8923676865283178800: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:47.354] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9089106927397825856:126:0) after 1m0s
[02:10:21.507] Received PubSub notification, asking Buildbucket for the build status
[02:10:21.554] Build 8923676865283178800: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:10:21.554] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1548123020298709",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1548115587878460",
"experimental": true,
"id": "8923676865283178800",
"parameters_json": "{\"builder_name\": \"Deterministic Android (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b2225c8da4715c5ccc49cf54880c12afbe2d2638\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Deterministic Android (dbg)\"], \"kvm\": [\"1\"], \"id\": [\"swarm629-c4\"], \"server_version\": [\"4012-9647885\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"builder_2bff2df219af63c0787c4be2031d3fbd218ec1b0853f1b8ce80b2331f0e04ffd_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"ff15c51d20785fa51c0ef03ccb480b87299acbeb\", \"got_swarming_client_revision\": \"0e3e1c4dc4e79f25a5b58fcbc135dc93183c0c54\", \"got_revision\": \"b2225c8da4715c5ccc49cf54880c12afbe2d2638\", \"recipe\": \"swarming/deterministic_build\", \"got_dawn_revision\": \"c0f31e73e481f32d308cb6232e75e6d860d97063\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#26298}\", \"$build/goma\": {\"jobs\": 150}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"got_revision_cp\": \"refs/heads/master@{#624697}\", \"branch\": \"refs/heads/master\", \"revision\": \"b2225c8da4715c5ccc49cf54880c12afbe2d2638\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Deterministic Android (dbg)\", \"got_webrtc_revision\": \"74ba99062c48b278675cfe52643719202296fddc\", \"mastername\": \"chromium.android\", \"got_angle_revision\": \"c81e7bfeb5580726f995776ed04fc4517d6d9c27\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1548115587878460, \"tags\": [\"builder:Deterministic Android (dbg)\", \"buildset:commit/git/b2225c8da4715c5ccc49cf54880c12afbe2d2638\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b2225c8da4715c5ccc49cf54880c12afbe2d2638\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9089106927397825856\", \"scheduler_job_id:chromium/Deterministic Android (dbg)\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.chromium.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"chromium\", \"id\": \"8923676865283178800\"}}, \"got_v8_revision\": \"00f40b9693c64563ec2ea1b6418028e44012f47e\", \"got_v8_revision_cp\": \"refs/heads/7.3.470@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": true, \"is_luci\": true}, \"buildnumber\": 3567, \"path_config\": \"generic\", \"bot_id\": \"swarm629-c4\", \"got_buildtools_revision\": \"2f02e1f363b1af2715536f38e239853f04ec1497\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1548115592121444",
"status": "COMPLETED",
"status_changed_ts": "1548123020789094",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android (dbg)/3567",
"builder:Deterministic Android (dbg)",
"buildset:commit/git/b2225c8da4715c5ccc49cf54880c12afbe2d2638",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b2225c8da4715c5ccc49cf54880c12afbe2d2638",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9089106927397825856",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_dimension:builder:Deterministic Android (dbg)",
"swarming_dimension:caches:builder_2bff2df219af63c0787c4be2031d3fbd218ec1b0853f1b8ce80b2331f0e04ffd_v2",
"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 (dbg)/3567",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8923676865283178800",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:01134cf47e8a2d5d7cea5ec1232ca64ed2f16a5c",
"swarming_tag:builder:Deterministic Android (dbg)",
"swarming_tag:buildset:commit/git/b2225c8da4715c5ccc49cf54880c12afbe2d2638",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b2225c8da4715c5ccc49cf54880c12afbe2d2638",
"swarming_tag:caches:builder_2bff2df219af63c0787c4be2031d3fbd218ec1b0853f1b8ce80b2331f0e04ffd_v2",
"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/8923676865283178800/+/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:9089106927397825856",
"swarming_tag:scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:4122e711faf74a549260c6de6a369a8fe79a9d3e",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:428bb2c0006ec010",
"user_agent:luci-scheduler"
],
"updated_ts": "1548123020796094",
"url": "https://ci.chromium.org/b/8923676865283178800",
"utcnow_ts": "1548123021543680"
}
}
[02:10:21.554] Invocation finished in 2h3m55.076169142s with status SUCCEEDED