[19:51:00.217] New invocation is queued and will start shortly
[19:51:01.527] Starting the invocation (attempt 1)
[19:51:01.564] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:51:01.564] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:51:01.564] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9107061197512791472",
"parameters_json": "{\"builder_name\":\"Deterministic Android (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"89f8047f0779227ae687109a7edceafca8d90f1e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Android (dbg)",
"scheduler_invocation_id:9107061197512791472",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/89f8047f0779227ae687109a7edceafca8d90f1e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/89f8047f0779227ae687109a7edceafca8d90f1e",
"gitiles_ref:refs/heads/master"
]
}
[19:51:03.575] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1530993061710240",
"experimental": true,
"id": "8941631135282671088",
"lease_expiration_ts": "1531029063303810",
"lease_key": "2057176769",
"parameters_json": "{\"builder_name\": \"Deterministic Android (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"89f8047f0779227ae687109a7edceafca8d90f1e\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1530993063487120",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android (dbg)/1815",
"builder:Deterministic Android (dbg)",
"buildset:commit/git/89f8047f0779227ae687109a7edceafca8d90f1e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/89f8047f0779227ae687109a7edceafca8d90f1e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9107061197512791472",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_dimension:builder:Deterministic Android (dbg)",
"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)/1815",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8941631135282671088",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
"swarming_tag:builder:Deterministic Android (dbg)",
"swarming_tag:buildset:commit/git/89f8047f0779227ae687109a7edceafca8d90f1e",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/89f8047f0779227ae687109a7edceafca8d90f1e",
"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/8941631135282671088/+/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:9107061197512791472",
"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:dfa6096ea25a84c1e3f6fa3a9f293c6aecf802a3",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e8f1dbc9435c710",
"user_agent:luci-scheduler"
],
"updated_ts": "1530993063487270",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Deterministic Android (dbg)/1815",
"utcnow_ts": "1530993063563690"
}
}
[19:51:03.575] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Deterministic Android (dbg)/1815
[19:51:03.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:2:0) after 1m0s
[19:51:05.530] Received PubSub notification, asking Buildbucket for the build status
[19:51:05.564] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:03.589] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:2:0)
[19:52:03.589] Timer tick, asking Buildbucket for the build status
[19:52:03.624] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:03.624] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:4:0) after 1m0s
[19:53:03.642] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:4:0)
[19:53:03.642] Timer tick, asking Buildbucket for the build status
[19:53:07.921] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:07.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:5:0) after 1m0s
[19:54:07.945] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:5:0)
[19:54:07.945] Timer tick, asking Buildbucket for the build status
[19:54:08.120] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:08.120] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:6:0) after 1m0s
[19:55:08.179] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:6:0)
[19:55:08.179] Timer tick, asking Buildbucket for the build status
[19:55:08.237] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:08.237] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:7:0) after 1m0s
[19:56:08.257] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:7:0)
[19:56:08.257] Timer tick, asking Buildbucket for the build status
[19:56:08.311] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:08.312] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:8:0) after 1m0s
[19:57:08.328] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:8:0)
[19:57:08.328] Timer tick, asking Buildbucket for the build status
[19:57:08.439] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:08.439] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:9:0) after 1m0s
[19:58:08.512] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:9:0)
[19:58:08.512] Timer tick, asking Buildbucket for the build status
[19:58:08.578] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:08.578] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:10:0) after 1m0s
[19:59:08.594] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:10:0)
[19:59:08.594] Timer tick, asking Buildbucket for the build status
[19:59:19.034] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:19.034] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:11:0) after 1m0s
[20:00:19.050] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:11:0)
[20:00:19.050] Timer tick, asking Buildbucket for the build status
[20:00:19.661] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:19.661] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:12:0) after 1m0s
[20:01:19.678] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:12:0)
[20:01:19.678] Timer tick, asking Buildbucket for the build status
[20:01:19.823] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:19.823] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:13:0) after 1m0s
[20:02:19.853] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:13:0)
[20:02:19.853] Timer tick, asking Buildbucket for the build status
[20:02:19.925] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:19.925] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:14:0) after 1m0s
[20:03:19.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:14:0)
[20:03:19.950] Timer tick, asking Buildbucket for the build status
[20:03:19.997] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:19.997] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:15:0) after 1m0s
[20:04:20.020] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:15:0)
[20:04:20.020] Timer tick, asking Buildbucket for the build status
[20:04:20.297] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:20.297] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:16:0) after 1m0s
[20:05:20.372] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:16:0)
[20:05:20.372] Timer tick, asking Buildbucket for the build status
[20:05:21.448] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:21.448] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:17:0) after 1m0s
[20:06:21.582] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:17:0)
[20:06:21.582] Timer tick, asking Buildbucket for the build status
[20:06:22.010] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:22.010] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:18:0) after 1m0s
[20:07:22.092] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:18:0)
[20:07:22.092] Timer tick, asking Buildbucket for the build status
[20:07:22.148] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:22.148] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:19:0) after 1m0s
[20:08:22.168] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:19:0)
[20:08:22.169] Timer tick, asking Buildbucket for the build status
[20:08:22.262] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:22.262] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:20:0) after 1m0s
[20:09:22.481] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:20:0)
[20:09:22.481] Timer tick, asking Buildbucket for the build status
[20:09:22.609] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:22.609] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:21:0) after 1m0s
[20:10:22.701] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:21:0)
[20:10:22.701] Timer tick, asking Buildbucket for the build status
[20:10:22.820] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:22.820] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:22:0) after 1m0s
[20:11:22.839] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:22:0)
[20:11:22.839] Timer tick, asking Buildbucket for the build status
[20:11:22.962] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:22.962] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:23:0) after 1m0s
[20:12:22.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:23:0)
[20:12:22.979] Timer tick, asking Buildbucket for the build status
[20:12:23.029] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:23.029] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:24:0) after 1m0s
[20:13:23.073] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:24:0)
[20:13:23.073] Timer tick, asking Buildbucket for the build status
[20:13:23.178] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:23.178] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:25:0) after 1m0s
[20:14:23.343] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:25:0)
[20:14:23.343] Timer tick, asking Buildbucket for the build status
[20:14:23.575] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:23.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:26:0) after 1m0s
[20:15:23.598] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:26:0)
[20:15:23.598] Timer tick, asking Buildbucket for the build status
[20:15:23.749] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:23.749] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:27:0) after 1m0s
[20:16:23.770] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:27:0)
[20:16:23.770] Timer tick, asking Buildbucket for the build status
[20:16:23.896] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:23.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:28:0) after 1m0s
[20:17:23.917] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:28:0)
[20:17:23.917] Timer tick, asking Buildbucket for the build status
[20:17:24.069] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:24.069] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:29:0) after 1m0s
[20:18:24.091] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:29:0)
[20:18:24.091] Timer tick, asking Buildbucket for the build status
[20:18:24.332] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:24.332] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:30:0) after 1m0s
[20:19:24.355] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:30:0)
[20:19:24.355] Timer tick, asking Buildbucket for the build status
[20:19:25.930] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:25.930] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:31:0) after 1m0s
[20:20:25.958] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:31:0)
[20:20:25.958] Timer tick, asking Buildbucket for the build status
[20:20:26.945] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:26.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:32:0) after 1m0s
[20:21:26.973] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:32:0)
[20:21:26.973] Timer tick, asking Buildbucket for the build status
[20:21:27.113] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:27.113] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:33:0) after 1m0s
[20:22:27.135] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:33:0)
[20:22:27.135] Timer tick, asking Buildbucket for the build status
[20:22:27.214] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:27.214] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:34:0) after 1m0s
[20:23:27.235] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:34:0)
[20:23:27.235] Timer tick, asking Buildbucket for the build status
[20:23:27.503] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:27.503] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:35:0) after 1m0s
[20:24:27.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:35:0)
[20:24:27.522] Timer tick, asking Buildbucket for the build status
[20:24:28.080] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:28.080] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:36:0) after 1m0s
[20:25:28.101] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:36:0)
[20:25:28.101] Timer tick, asking Buildbucket for the build status
[20:25:28.199] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:28.199] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:37:0) after 1m0s
[20:26:28.276] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:37:0)
[20:26:28.276] Timer tick, asking Buildbucket for the build status
[20:26:28.503] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:28.503] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:38:0) after 1m0s
[20:27:28.535] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:38:0)
[20:27:28.535] Timer tick, asking Buildbucket for the build status
[20:27:28.632] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:28.632] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:39:0) after 1m0s
[20:28:28.653] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:39:0)
[20:28:28.653] Timer tick, asking Buildbucket for the build status
[20:28:29.012] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:29.012] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:40:0) after 1m0s
[20:29:29.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:40:0)
[20:29:29.037] Timer tick, asking Buildbucket for the build status
[20:29:30.419] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:30.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:41:0) after 1m0s
[20:30:30.474] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:41:0)
[20:30:30.474] Timer tick, asking Buildbucket for the build status
[20:30:31.234] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:31.234] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:42:0) after 1m0s
[20:31:31.363] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:42:0)
[20:31:31.363] Timer tick, asking Buildbucket for the build status
[20:31:32.218] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:32.218] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:43:0) after 1m0s
[20:32:32.237] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:43:0)
[20:32:32.237] Timer tick, asking Buildbucket for the build status
[20:32:32.544] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:32.544] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:44:0) after 1m0s
[20:33:32.564] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:44:0)
[20:33:32.564] Timer tick, asking Buildbucket for the build status
[20:33:32.709] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:32.709] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:45:0) after 1m0s
[20:34:32.729] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:45:0)
[20:34:32.729] Timer tick, asking Buildbucket for the build status
[20:34:33.146] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:33.146] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:46:0) after 1m0s
[20:35:33.166] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:46:0)
[20:35:33.166] Timer tick, asking Buildbucket for the build status
[20:35:33.204] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:33.204] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:47:0) after 1m0s
[20:36:33.236] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:47:0)
[20:36:33.236] Timer tick, asking Buildbucket for the build status
[20:36:33.417] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:33.417] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:48:0) after 1m0s
[20:37:33.437] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:48:0)
[20:37:33.437] Timer tick, asking Buildbucket for the build status
[20:37:33.665] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:33.665] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:49:0) after 1m0s
[20:38:33.681] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:49:0)
[20:38:33.681] Timer tick, asking Buildbucket for the build status
[20:38:33.814] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:33.814] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:50:0) after 1m0s
[20:39:33.838] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:50:0)
[20:39:33.838] Timer tick, asking Buildbucket for the build status
[20:39:33.950] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:33.950] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:51:0) after 1m0s
[20:40:34.054] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:51:0)
[20:40:34.054] Timer tick, asking Buildbucket for the build status
[20:40:34.112] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:34.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:52:0) after 1m0s
[20:41:34.175] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:52:0)
[20:41:34.175] Timer tick, asking Buildbucket for the build status
[20:41:34.268] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:34.268] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:53:0) after 1m0s
[20:42:34.286] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:53:0)
[20:42:34.286] Timer tick, asking Buildbucket for the build status
[20:42:34.550] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:34.550] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:54:0) after 1m0s
[20:43:34.569] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:54:0)
[20:43:34.569] Timer tick, asking Buildbucket for the build status
[20:43:34.622] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:34.622] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:55:0) after 1m0s
[20:44:34.643] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:55:0)
[20:44:34.643] Timer tick, asking Buildbucket for the build status
[20:44:34.720] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:34.720] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:56:0) after 1m0s
[20:45:34.879] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:56:0)
[20:45:34.879] Timer tick, asking Buildbucket for the build status
[20:45:35.429] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:35.429] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:57:0) after 1m0s
[20:46:35.448] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:57:0)
[20:46:35.448] Timer tick, asking Buildbucket for the build status
[20:46:35.499] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:35.499] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:58:0) after 1m0s
[20:47:35.517] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:58:0)
[20:47:35.517] Timer tick, asking Buildbucket for the build status
[20:47:35.618] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:35.618] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:59:0) after 1m0s
[20:48:35.644] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:59:0)
[20:48:35.644] Timer tick, asking Buildbucket for the build status
[20:48:35.756] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:35.756] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:60:0) after 1m0s
[20:49:35.834] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:60:0)
[20:49:35.834] Timer tick, asking Buildbucket for the build status
[20:49:36.038] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:36.038] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:61:0) after 1m0s
[20:50:36.063] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:61:0)
[20:50:36.063] Timer tick, asking Buildbucket for the build status
[20:50:36.226] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:36.226] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:62:0) after 1m0s
[20:51:36.244] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:62:0)
[20:51:36.244] Timer tick, asking Buildbucket for the build status
[20:51:36.306] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:36.306] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:63:0) after 1m0s
[20:52:36.356] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:63:0)
[20:52:36.356] Timer tick, asking Buildbucket for the build status
[20:52:36.417] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:36.417] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:64:0) after 1m0s
[20:53:36.436] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:64:0)
[20:53:36.436] Timer tick, asking Buildbucket for the build status
[20:53:36.508] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:36.508] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:65:0) after 1m0s
[20:54:36.538] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:65:0)
[20:54:36.538] Timer tick, asking Buildbucket for the build status
[20:54:36.595] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:36.595] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:66:0) after 1m0s
[20:55:36.623] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:66:0)
[20:55:36.623] Timer tick, asking Buildbucket for the build status
[20:55:36.712] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:36.712] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:67:0) after 1m0s
[20:56:36.731] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:67:0)
[20:56:36.731] Timer tick, asking Buildbucket for the build status
[20:56:36.790] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:36.790] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:68:0) after 1m0s
[20:57:36.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:68:0)
[20:57:36.838] Timer tick, asking Buildbucket for the build status
[20:57:36.891] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:36.891] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:69:0) after 1m0s
[20:58:36.913] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:69:0)
[20:58:36.913] Timer tick, asking Buildbucket for the build status
[20:58:36.991] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:36.991] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:70:0) after 1m0s
[20:59:37.009] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:70:0)
[20:59:37.009] Timer tick, asking Buildbucket for the build status
[20:59:37.105] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:37.105] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:71:0) after 1m0s
[21:00:37.124] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:71:0)
[21:00:37.124] Timer tick, asking Buildbucket for the build status
[21:00:37.235] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:37.235] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:72:0) after 1m0s
[21:01:37.317] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:72:0)
[21:01:37.317] Timer tick, asking Buildbucket for the build status
[21:01:37.529] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:37.529] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:73:0) after 1m0s
[21:02:37.548] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:73:0)
[21:02:37.548] Timer tick, asking Buildbucket for the build status
[21:02:37.724] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:37.724] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:74:0) after 1m0s
[21:03:37.745] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:74:0)
[21:03:37.745] Timer tick, asking Buildbucket for the build status
[21:03:37.801] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:37.801] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:75:0) after 1m0s
[21:04:37.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:75:0)
[21:04:37.837] Timer tick, asking Buildbucket for the build status
[21:04:37.928] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:37.928] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:76:0) after 1m0s
[21:05:38.014] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:76:0)
[21:05:38.014] Timer tick, asking Buildbucket for the build status
[21:05:38.146] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:38.146] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:77:0) after 1m0s
[21:06:38.265] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:77:0)
[21:06:38.265] Timer tick, asking Buildbucket for the build status
[21:06:38.347] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:38.347] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:78:0) after 1m0s
[21:07:38.460] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:78:0)
[21:07:38.460] Timer tick, asking Buildbucket for the build status
[21:07:38.672] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:38.672] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:79:0) after 1m0s
[21:08:38.691] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:79:0)
[21:08:38.691] Timer tick, asking Buildbucket for the build status
[21:08:38.735] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:38.735] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:80:0) after 1m0s
[21:09:38.800] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:80:0)
[21:09:38.800] Timer tick, asking Buildbucket for the build status
[21:09:38.848] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:38.848] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:81:0) after 1m0s
[21:10:38.876] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:81:0)
[21:10:38.876] Timer tick, asking Buildbucket for the build status
[21:10:39.001] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:39.001] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:82:0) after 1m0s
[21:11:39.020] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:82:0)
[21:11:39.020] Timer tick, asking Buildbucket for the build status
[21:11:39.252] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:39.252] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:83:0) after 1m0s
[21:12:39.276] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:83:0)
[21:12:39.276] Timer tick, asking Buildbucket for the build status
[21:12:39.319] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:39.319] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:84:0) after 1m0s
[21:13:39.457] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:84:0)
[21:13:39.457] Timer tick, asking Buildbucket for the build status
[21:13:39.761] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:39.762] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:85:0) after 1m0s
[21:14:39.781] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:85:0)
[21:14:39.781] Timer tick, asking Buildbucket for the build status
[21:14:39.829] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:39.829] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:86:0) after 1m0s
[21:15:39.853] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:86:0)
[21:15:39.853] Timer tick, asking Buildbucket for the build status
[21:15:39.912] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:39.912] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:87:0) after 1m0s
[21:16:39.933] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:87:0)
[21:16:39.933] Timer tick, asking Buildbucket for the build status
[21:16:40.155] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:40.155] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:88:0) after 1m0s
[21:17:40.177] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:88:0)
[21:17:40.177] Timer tick, asking Buildbucket for the build status
[21:17:40.316] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:40.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:89:0) after 1m0s
[21:18:40.358] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:89:0)
[21:18:40.358] Timer tick, asking Buildbucket for the build status
[21:18:40.463] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:40.463] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:90:0) after 1m0s
[21:19:40.484] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:90:0)
[21:19:40.484] Timer tick, asking Buildbucket for the build status
[21:19:40.623] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:40.623] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:91:0) after 1m0s
[21:20:40.642] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:91:0)
[21:20:40.643] Timer tick, asking Buildbucket for the build status
[21:20:40.725] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:40.725] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:92:0) after 1m0s
[21:21:40.757] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:92:0)
[21:21:40.757] Timer tick, asking Buildbucket for the build status
[21:21:41.128] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:41.128] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:93:0) after 1m0s
[21:22:41.205] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:93:0)
[21:22:41.205] Timer tick, asking Buildbucket for the build status
[21:22:41.510] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:41.510] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:94:0) after 1m0s
[21:23:41.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:94:0)
[21:23:41.586] Timer tick, asking Buildbucket for the build status
[21:23:41.773] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:41.773] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:95:0) after 1m0s
[21:24:41.856] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:95:0)
[21:24:41.856] Timer tick, asking Buildbucket for the build status
[21:24:41.966] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:41.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:96:0) after 1m0s
[21:25:42.151] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:96:0)
[21:25:42.151] Timer tick, asking Buildbucket for the build status
[21:25:42.225] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:42.225] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:97:0) after 1m0s
[21:26:42.247] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:97:0)
[21:26:42.247] Timer tick, asking Buildbucket for the build status
[21:26:42.326] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:42.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:98:0) after 1m0s
[21:27:42.473] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:98:0)
[21:27:42.473] Timer tick, asking Buildbucket for the build status
[21:27:42.535] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:42.535] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:99:0) after 1m0s
[21:28:42.649] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:99:0)
[21:28:42.649] Timer tick, asking Buildbucket for the build status
[21:28:42.806] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:42.806] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:100:0) after 1m0s
[21:29:42.849] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:100:0)
[21:29:42.849] Timer tick, asking Buildbucket for the build status
[21:29:42.903] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:42.903] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:101:0) after 1m0s
[21:30:43.049] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:101:0)
[21:30:43.049] Timer tick, asking Buildbucket for the build status
[21:30:43.416] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:43.416] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:102:0) after 1m0s
[21:31:43.434] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:102:0)
[21:31:43.434] Timer tick, asking Buildbucket for the build status
[21:31:43.502] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:43.502] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:103:0) after 1m0s
[21:32:43.572] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:103:0)
[21:32:43.572] Timer tick, asking Buildbucket for the build status
[21:32:43.736] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:43.736] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:104:0) after 1m0s
[21:33:43.855] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:104:0)
[21:33:43.855] Timer tick, asking Buildbucket for the build status
[21:33:44.131] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:44.131] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:105:0) after 1m0s
[21:34:44.152] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:105:0)
[21:34:44.152] Timer tick, asking Buildbucket for the build status
[21:34:44.742] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:44.742] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:106:0) after 1m0s
[21:35:44.760] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:106:0)
[21:35:44.760] Timer tick, asking Buildbucket for the build status
[21:35:44.811] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:44.811] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:107:0) after 1m0s
[21:36:44.864] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:107:0)
[21:36:44.864] Timer tick, asking Buildbucket for the build status
[21:36:45.101] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:45.101] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:108:0) after 1m0s
[21:37:45.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:108:0)
[21:37:45.195] Timer tick, asking Buildbucket for the build status
[21:37:45.265] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:45.265] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:109:0) after 1m0s
[21:38:45.286] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:109:0)
[21:38:45.286] Timer tick, asking Buildbucket for the build status
[21:38:45.344] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:45.344] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:110:0) after 1m0s
[21:39:45.386] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:110:0)
[21:39:45.386] Timer tick, asking Buildbucket for the build status
[21:39:45.441] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:45.441] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:111:0) after 1m0s
[21:40:45.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:111:0)
[21:40:45.549] Timer tick, asking Buildbucket for the build status
[21:40:45.694] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:45.694] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:112:0) after 1m0s
[21:41:45.787] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:112:0)
[21:41:45.787] Timer tick, asking Buildbucket for the build status
[21:41:46.023] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:46.023] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:113:0) after 1m0s
[21:42:46.045] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:113:0)
[21:42:46.045] Timer tick, asking Buildbucket for the build status
[21:42:46.320] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:46.320] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:114:0) after 1m0s
[21:43:46.524] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:114:0)
[21:43:46.524] Timer tick, asking Buildbucket for the build status
[21:43:46.716] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:46.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:115:0) after 1m0s
[21:44:46.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:115:0)
[21:44:46.741] Timer tick, asking Buildbucket for the build status
[21:44:47.214] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:47.214] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:116:0) after 1m0s
[21:45:47.233] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:116:0)
[21:45:47.233] Timer tick, asking Buildbucket for the build status
[21:45:47.291] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:47.291] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:117:0) after 1m0s
[21:46:47.336] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:117:0)
[21:46:47.336] Timer tick, asking Buildbucket for the build status
[21:46:47.395] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:47.395] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:118:0) after 1m0s
[21:47:47.412] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:118:0)
[21:47:47.412] Timer tick, asking Buildbucket for the build status
[21:47:47.613] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:47.613] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:119:0) after 1m0s
[21:48:47.639] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:119:0)
[21:48:47.639] Timer tick, asking Buildbucket for the build status
[21:48:47.854] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:47.854] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:120:0) after 1m0s
[21:49:47.877] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:120:0)
[21:49:47.877] Timer tick, asking Buildbucket for the build status
[21:49:47.968] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:47.968] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:121:0) after 1m0s
[21:50:47.992] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:121:0)
[21:50:47.992] Timer tick, asking Buildbucket for the build status
[21:50:48.103] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:48.103] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:122:0) after 1m0s
[21:51:48.134] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:122:0)
[21:51:48.134] Timer tick, asking Buildbucket for the build status
[21:51:48.224] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:48.224] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:123:0) after 1m0s
[21:52:48.257] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:123:0)
[21:52:48.257] Timer tick, asking Buildbucket for the build status
[21:52:48.339] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:48.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:124:0) after 1m0s
[21:53:48.356] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:124:0)
[21:53:48.356] Timer tick, asking Buildbucket for the build status
[21:53:48.502] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:48.502] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:125:0) after 1m0s
[21:54:48.521] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:125:0)
[21:54:48.521] Timer tick, asking Buildbucket for the build status
[21:54:48.589] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:48.589] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:126:0) after 1m0s
[21:55:48.613] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:126:0)
[21:55:48.613] Timer tick, asking Buildbucket for the build status
[21:55:48.822] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:48.822] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:127:0) after 1m0s
[21:56:48.847] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:127:0)
[21:56:48.847] Timer tick, asking Buildbucket for the build status
[21:56:48.956] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:48.956] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:128:0) after 1m0s
[21:57:48.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:128:0)
[21:57:48.979] Timer tick, asking Buildbucket for the build status
[21:57:49.139] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:49.139] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:129:0) after 1m0s
[21:58:49.162] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:129:0)
[21:58:49.162] Timer tick, asking Buildbucket for the build status
[21:58:49.328] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:49.328] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:130:0) after 1m0s
[21:59:49.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:130:0)
[21:59:49.351] Timer tick, asking Buildbucket for the build status
[21:59:49.527] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:49.527] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:131:0) after 1m0s
[22:00:49.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:131:0)
[22:00:49.549] Timer tick, asking Buildbucket for the build status
[22:00:49.605] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:49.605] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:132:0) after 1m0s
[22:01:49.624] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:132:0)
[22:01:49.624] Timer tick, asking Buildbucket for the build status
[22:01:49.695] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:49.695] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:133:0) after 1m0s
[22:02:49.852] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:133:0)
[22:02:49.852] Timer tick, asking Buildbucket for the build status
[22:02:49.900] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:49.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:134:0) after 1m0s
[22:03:49.920] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:134:0)
[22:03:49.920] Timer tick, asking Buildbucket for the build status
[22:03:49.976] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:49.976] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:135:0) after 1m0s
[22:04:50.004] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:135:0)
[22:04:50.004] Timer tick, asking Buildbucket for the build status
[22:04:50.433] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:50.433] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:136:0) after 1m0s
[22:05:50.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:136:0)
[22:05:50.477] Timer tick, asking Buildbucket for the build status
[22:05:50.638] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:50.639] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:137:0) after 1m0s
[22:06:50.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:137:0)
[22:06:50.658] Timer tick, asking Buildbucket for the build status
[22:06:50.750] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:50.750] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:138:0) after 1m0s
[22:07:50.771] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:138:0)
[22:07:50.771] Timer tick, asking Buildbucket for the build status
[22:07:50.822] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:50.822] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:139:0) after 1m0s
[22:08:50.859] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:139:0)
[22:08:50.859] Timer tick, asking Buildbucket for the build status
[22:08:50.913] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:50.913] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:140:0) after 1m0s
[22:09:50.955] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:140:0)
[22:09:50.955] Timer tick, asking Buildbucket for the build status
[22:09:51.033] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:51.033] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:141:0) after 1m0s
[22:10:51.079] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:141:0)
[22:10:51.079] Timer tick, asking Buildbucket for the build status
[22:10:51.132] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:51.132] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:142:0) after 1m0s
[22:11:51.153] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:142:0)
[22:11:51.153] Timer tick, asking Buildbucket for the build status
[22:11:51.301] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:51.301] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:143:0) after 1m0s
[22:12:51.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:143:0)
[22:12:51.351] Timer tick, asking Buildbucket for the build status
[22:12:51.496] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:51.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:144:0) after 1m0s
[22:13:51.518] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:144:0)
[22:13:51.518] Timer tick, asking Buildbucket for the build status
[22:13:51.690] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:51.690] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:145:0) after 1m0s
[22:14:51.832] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:145:0)
[22:14:51.832] Timer tick, asking Buildbucket for the build status
[22:14:51.906] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:51.906] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:146:0) after 1m0s
[22:15:51.969] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:146:0)
[22:15:51.969] Timer tick, asking Buildbucket for the build status
[22:15:52.015] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:52.015] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:147:0) after 1m0s
[22:16:52.162] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:147:0)
[22:16:52.162] Timer tick, asking Buildbucket for the build status
[22:16:52.236] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:52.236] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:148:0) after 1m0s
[22:17:52.440] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:148:0)
[22:17:52.440] Timer tick, asking Buildbucket for the build status
[22:17:52.497] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:52.497] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:149:0) after 1m0s
[22:18:52.739] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:149:0)
[22:18:52.739] Timer tick, asking Buildbucket for the build status
[22:18:52.806] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:52.806] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:150:0) after 1m0s
[22:19:53.012] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:150:0)
[22:19:53.012] Timer tick, asking Buildbucket for the build status
[22:19:53.169] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:53.169] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:151:0) after 1m0s
[22:20:53.332] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:151:0)
[22:20:53.332] Timer tick, asking Buildbucket for the build status
[22:20:53.389] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:53.389] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:152:0) after 1m0s
[22:21:53.634] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:152:0)
[22:21:53.634] Timer tick, asking Buildbucket for the build status
[22:21:53.702] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:53.702] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:153:0) after 1m0s
[22:22:53.821] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:153:0)
[22:22:53.821] Timer tick, asking Buildbucket for the build status
[22:22:53.927] Build 8941631135282671088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:53.927] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107061197512791472:154:0) after 1m0s
[22:23:43.850] Received PubSub notification, asking Buildbucket for the build status
[22:23:43.886] Build 8941631135282671088: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[22:23:43.886] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1531002222207920",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1530993061710240",
"experimental": true,
"failure_reason": "INFRA_FAILURE",
"id": "8941631135282671088",
"parameters_json": "{\"builder_name\": \"Deterministic Android (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"89f8047f0779227ae687109a7edceafca8d90f1e\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"Failure compare_build_artifacts\\nFailure Uncaught Exception\"}, \"build_run_result\": {\"infraFailure\": {\"text\": \"recipe infra failure: Uncaught Exception: AttributeError(\\\"'NoneType' object has no attribute 'itervalues'\\\",)\", \"bootstrapperCallStack\": [], \"type\": \"RECIPE_INFRA_FAILURE\"}, \"recipeResult\": {\"failure\": {\"exception\": {\"traceback\": [\"Traceback (most recent call last):\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/run.py\\\", line 287, in _new_run\", \" recipe_result = recipe_script.run(api, self.properties, self.environ)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/loader.py\\\", line 108, in run\", \" self.run_steps, properties, environ, self.PROPERTIES, api=api)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/loader.py\\\", line 636, in invoke_with_properties\", \" arg_names, **additional_args)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/loader.py\\\", line 599, in _invoke_with_properties\", \" return callable_obj(*props, **additional_args)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipes/swarming/deterministic_build.py\\\", line 194, in RunSteps\", \" str(api.chromium.output_dir).rstrip('\\\\\\\\/') + '.2')\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/recipe_api.py\\\", line 759, in _inner\", \" return func(*a, **kw)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/isolate/api.py\\\", line 350, in compare_build_artifacts\", \" self.archive_differences(first_dir, second_dir, step_result.json.output)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/recipe_engine/recipe_engine/recipe_api.py\\\", line 759, in _inner\", \" return func(*a, **kw)\", \" File \\\"/b/swarming/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/isolate/api.py\\\", line 302, in archive_differences\", \" diffs = list(itertools.chain.from_iterable(values.itervalues()))\", \"AttributeError: 'NoneType' object has no attribute 'itervalues'\"]}, \"humanReason\": \"Uncaught Exception: AttributeError(\\\"'NoneType' object has no attribute 'itervalues'\\\",)\"}}, \"recipeExitCode\": {\"value\": 1}, \"recipe\": {\"name\": \"swarming/deterministic_build\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8941631135282671088/+/annotations\"}, \"swarming\": {\"bot_dimensions\": {\"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Deterministic Android (dbg)\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3675-21ffa58\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"swarm629-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"030b88a205c9ce9a82d68798bfaa059fd55216cd\", \"got_swarming_client_revision\": \"9a518d097dca20b7b00ce3bdfc5d418ccc79893a\", \"got_revision\": \"89f8047f0779227ae687109a7edceafca8d90f1e\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#23879}\", \"$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@{#573172}\", \"got_src_revision\": \"89f8047f0779227ae687109a7edceafca8d90f1e\", \"got_revision_cp\": \"refs/heads/master@{#573172}\", \"branch\": \"refs/heads/master\", \"revision\": \"89f8047f0779227ae687109a7edceafca8d90f1e\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Deterministic Android (dbg)\", \"got_webrtc_revision\": \"0d405d41bdba864f92d6ce10e80fbf1bc2b9fe89\", \"mastername\": \"chromium.android\", \"got_angle_revision\": \"7e585118fe827063e715c3741c3f43c4dd677ec2\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1530993061710240, \"tags\": [\"builder:Deterministic Android (dbg)\", \"buildset:commit/git/89f8047f0779227ae687109a7edceafca8d90f1e\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/89f8047f0779227ae687109a7edceafca8d90f1e\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9107061197512791472\", \"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\": \"8941631135282671088\"}}, \"got_v8_revision\": \"c7d30add28811721d2eda361b469bc3c7cac67f8\", \"got_v8_revision_cp\": \"refs/heads/6.9.322@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": true, \"is_luci\": true}, \"buildnumber\": 1815, \"path_config\": \"generic\", \"bot_id\": \"swarm629-c4\", \"got_buildtools_revision\": \"0dd5c6f980d22be96b728155249df2da355989d9\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1530993064238520",
"status": "COMPLETED",
"status_changed_ts": "1531002223225090",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android (dbg)/1815",
"builder:Deterministic Android (dbg)",
"buildset:commit/git/89f8047f0779227ae687109a7edceafca8d90f1e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/89f8047f0779227ae687109a7edceafca8d90f1e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9107061197512791472",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_dimension:builder:Deterministic Android (dbg)",
"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)/1815",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8941631135282671088",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4e8cd6081d2622e2214b4bbd0cdf5e2ba5406635",
"swarming_tag:builder:Deterministic Android (dbg)",
"swarming_tag:buildset:commit/git/89f8047f0779227ae687109a7edceafca8d90f1e",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/89f8047f0779227ae687109a7edceafca8d90f1e",
"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/8941631135282671088/+/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:9107061197512791472",
"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:dfa6096ea25a84c1e3f6fa3a9f293c6aecf802a3",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e8f1dbc9435c710",
"user_agent:luci-scheduler"
],
"updated_ts": "1531002223226410",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Deterministic Android (dbg)/1815",
"utcnow_ts": "1531002223874970"
}
}
[22:23:43.886] Invocation finished in 2h32m43.685523828s with status FAILED