[07:45:26.203] New invocation is queued and will start shortly
[07:45:27.426] Starting the invocation (attempt 1)
[07:45:27.465] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:45:27.465] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:45:27.465] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9107469234097730512",
"parameters_json": "{\"builder_name\":\"Deterministic Android (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"fdf6a8b74b61a022c931d99100939b699314b85d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Android (dbg)",
"scheduler_invocation_id:9107469234097730512",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/fdf6a8b74b61a022c931d99100939b699314b85d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fdf6a8b74b61a022c931d99100939b699314b85d",
"gitiles_ref:refs/heads/master"
]
}
[07:45:28.703] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1530603927574010",
"experimental": true,
"id": "8942039171998126144",
"lease_expiration_ts": "1530639928274310",
"lease_key": "375556993",
"parameters_json": "{\"builder_name\": \"Deterministic Android (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fdf6a8b74b61a022c931d99100939b699314b85d\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1530603928503790",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android (dbg)/1773",
"builder:Deterministic Android (dbg)",
"buildset:commit/git/fdf6a8b74b61a022c931d99100939b699314b85d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fdf6a8b74b61a022c931d99100939b699314b85d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9107469234097730512",
"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)/1773",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8942039171998126144",
"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/fdf6a8b74b61a022c931d99100939b699314b85d",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fdf6a8b74b61a022c931d99100939b699314b85d",
"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/8942039171998126144/+/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:9107469234097730512",
"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:761be570b9ddc8b12cd9bf031b7ba136a1879f33",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e77ec022b9ac710",
"user_agent:luci-scheduler"
],
"updated_ts": "1530603928503960",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Deterministic Android (dbg)/1773",
"utcnow_ts": "1530603928635910"
}
}
[07:45:28.703] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Deterministic Android (dbg)/1773
[07:45:28.703] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:2:0) after 1m0s
[07:46:02.753] Received PubSub notification, asking Buildbucket for the build status
[07:46:02.841] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:28.722] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:2:0)
[07:46:28.722] Timer tick, asking Buildbucket for the build status
[07:46:28.751] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:28.751] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:4:0) after 1m0s
[07:47:28.774] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:4:0)
[07:47:28.774] Timer tick, asking Buildbucket for the build status
[07:47:28.832] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:28.832] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:5:0) after 1m0s
[07:48:28.850] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:5:0)
[07:48:28.850] Timer tick, asking Buildbucket for the build status
[07:48:29.057] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:29.057] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:6:0) after 1m0s
[07:49:29.095] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:6:0)
[07:49:29.095] Timer tick, asking Buildbucket for the build status
[07:49:29.244] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:29.244] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:7:0) after 1m0s
[07:50:29.259] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:7:0)
[07:50:29.259] Timer tick, asking Buildbucket for the build status
[07:50:29.373] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:29.373] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:8:0) after 1m0s
[07:51:29.390] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:8:0)
[07:51:29.390] Timer tick, asking Buildbucket for the build status
[07:51:29.530] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:29.530] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:9:0) after 1m0s
[07:52:29.552] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:9:0)
[07:52:29.552] Timer tick, asking Buildbucket for the build status
[07:52:29.603] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:29.603] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:10:0) after 1m0s
[07:53:29.620] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:10:0)
[07:53:29.620] Timer tick, asking Buildbucket for the build status
[07:53:29.689] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:29.689] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:11:0) after 1m0s
[07:54:29.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:11:0)
[07:54:29.777] Timer tick, asking Buildbucket for the build status
[07:54:29.942] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:29.942] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:12:0) after 1m0s
[07:55:29.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:12:0)
[07:55:29.962] Timer tick, asking Buildbucket for the build status
[07:55:30.077] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:30.077] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:13:0) after 1m0s
[07:56:30.096] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:13:0)
[07:56:30.096] Timer tick, asking Buildbucket for the build status
[07:56:30.159] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:30.159] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:14:0) after 1m0s
[07:57:30.179] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:14:0)
[07:57:30.179] Timer tick, asking Buildbucket for the build status
[07:57:30.259] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:30.259] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:15:0) after 1m0s
[07:58:30.309] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:15:0)
[07:58:30.309] Timer tick, asking Buildbucket for the build status
[07:58:30.502] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:30.502] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:16:0) after 1m0s
[07:59:30.525] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:16:0)
[07:59:30.525] Timer tick, asking Buildbucket for the build status
[07:59:30.574] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:30.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:17:0) after 1m0s
[08:00:30.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:17:0)
[08:00:30.592] Timer tick, asking Buildbucket for the build status
[08:00:30.668] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:30.668] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:18:0) after 1m0s
[08:01:30.701] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:18:0)
[08:01:30.701] Timer tick, asking Buildbucket for the build status
[08:01:30.773] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:30.773] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:19:0) after 1m0s
[08:02:30.790] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:19:0)
[08:02:30.790] Timer tick, asking Buildbucket for the build status
[08:02:30.859] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:30.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:20:0) after 1m0s
[08:03:30.911] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:20:0)
[08:03:30.911] Timer tick, asking Buildbucket for the build status
[08:03:30.968] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:30.968] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:21:0) after 1m0s
[08:04:30.987] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:21:0)
[08:04:30.987] Timer tick, asking Buildbucket for the build status
[08:04:31.108] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:31.108] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:22:0) after 1m0s
[08:05:31.203] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:22:0)
[08:05:31.203] Timer tick, asking Buildbucket for the build status
[08:05:31.363] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:31.364] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:23:0) after 1m0s
[08:06:31.383] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:23:0)
[08:06:31.383] Timer tick, asking Buildbucket for the build status
[08:06:31.540] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:31.540] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:24:0) after 1m0s
[08:07:31.559] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:24:0)
[08:07:31.559] Timer tick, asking Buildbucket for the build status
[08:07:31.622] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:31.622] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:25:0) after 1m0s
[08:08:31.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:25:0)
[08:08:31.741] Timer tick, asking Buildbucket for the build status
[08:08:31.844] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:31.844] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:26:0) after 1m0s
[08:09:31.864] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:26:0)
[08:09:31.864] Timer tick, asking Buildbucket for the build status
[08:09:32.144] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:32.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:27:0) after 1m0s
[08:10:32.164] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:27:0)
[08:10:32.164] Timer tick, asking Buildbucket for the build status
[08:10:32.215] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:32.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:28:0) after 1m0s
[08:11:32.234] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:28:0)
[08:11:32.234] Timer tick, asking Buildbucket for the build status
[08:11:32.289] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:32.289] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:29:0) after 1m0s
[08:12:32.327] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:29:0)
[08:12:32.327] Timer tick, asking Buildbucket for the build status
[08:12:32.402] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:32.402] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:30:0) after 1m0s
[08:13:32.420] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:30:0)
[08:13:32.420] Timer tick, asking Buildbucket for the build status
[08:13:32.533] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:32.533] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:31:0) after 1m0s
[08:14:32.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:31:0)
[08:14:32.596] Timer tick, asking Buildbucket for the build status
[08:14:32.742] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:32.742] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:32:0) after 1m0s
[08:15:32.762] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:32:0)
[08:15:32.762] Timer tick, asking Buildbucket for the build status
[08:15:32.932] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:32.932] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:33:0) after 1m0s
[08:16:32.961] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:33:0)
[08:16:32.961] Timer tick, asking Buildbucket for the build status
[08:16:33.280] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:33.280] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:34:0) after 1m0s
[08:17:33.331] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:34:0)
[08:17:33.331] Timer tick, asking Buildbucket for the build status
[08:17:33.469] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:33.469] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:35:0) after 1m0s
[08:18:33.491] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:35:0)
[08:18:33.491] Timer tick, asking Buildbucket for the build status
[08:18:33.617] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:33.617] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:36:0) after 1m0s
[08:19:33.642] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:36:0)
[08:19:33.642] Timer tick, asking Buildbucket for the build status
[08:19:33.731] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:33.731] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:37:0) after 1m0s
[08:20:33.802] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:37:0)
[08:20:33.802] Timer tick, asking Buildbucket for the build status
[08:20:34.016] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:34.016] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:38:0) after 1m0s
[08:21:34.036] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:38:0)
[08:21:34.036] Timer tick, asking Buildbucket for the build status
[08:21:34.245] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:34.245] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:39:0) after 1m0s
[08:22:34.266] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:39:0)
[08:22:34.266] Timer tick, asking Buildbucket for the build status
[08:22:34.322] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:34.322] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:40:0) after 1m0s
[08:23:34.345] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:40:0)
[08:23:34.345] Timer tick, asking Buildbucket for the build status
[08:23:34.407] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:34.407] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:41:0) after 1m0s
[08:24:34.431] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:41:0)
[08:24:34.431] Timer tick, asking Buildbucket for the build status
[08:24:34.481] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:34.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:42:0) after 1m0s
[08:25:34.501] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:42:0)
[08:25:34.501] Timer tick, asking Buildbucket for the build status
[08:25:34.575] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:34.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:43:0) after 1m0s
[08:26:34.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:43:0)
[08:26:34.596] Timer tick, asking Buildbucket for the build status
[08:26:34.813] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:34.813] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:44:0) after 1m0s
[08:27:34.832] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:44:0)
[08:27:34.832] Timer tick, asking Buildbucket for the build status
[08:27:34.937] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:34.937] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:45:0) after 1m0s
[08:28:34.959] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:45:0)
[08:28:34.959] Timer tick, asking Buildbucket for the build status
[08:28:35.011] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:35.011] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:46:0) after 1m0s
[08:29:35.035] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:46:0)
[08:29:35.035] Timer tick, asking Buildbucket for the build status
[08:29:35.187] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:35.187] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:47:0) after 1m0s
[08:30:35.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:47:0)
[08:30:35.218] Timer tick, asking Buildbucket for the build status
[08:30:35.285] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:35.285] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:48:0) after 1m0s
[08:31:35.391] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:48:0)
[08:31:35.391] Timer tick, asking Buildbucket for the build status
[08:31:35.469] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:35.469] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:49:0) after 1m0s
[08:32:35.491] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:49:0)
[08:32:35.491] Timer tick, asking Buildbucket for the build status
[08:32:35.676] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:35.676] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:50:0) after 1m0s
[08:33:35.697] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:50:0)
[08:33:35.697] Timer tick, asking Buildbucket for the build status
[08:33:35.853] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:35.853] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:51:0) after 1m0s
[08:34:35.880] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:51:0)
[08:34:35.880] Timer tick, asking Buildbucket for the build status
[08:34:36.063] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:36.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:52:0) after 1m0s
[08:35:36.086] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:52:0)
[08:35:36.086] Timer tick, asking Buildbucket for the build status
[08:35:36.152] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:36.152] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:53:0) after 1m0s
[08:36:36.175] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:53:0)
[08:36:36.175] Timer tick, asking Buildbucket for the build status
[08:36:36.233] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:36.233] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:54:0) after 1m0s
[08:37:36.253] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:54:0)
[08:37:36.253] Timer tick, asking Buildbucket for the build status
[08:37:36.293] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:36.293] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:55:0) after 1m0s
[08:38:36.312] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:55:0)
[08:38:36.312] Timer tick, asking Buildbucket for the build status
[08:38:36.439] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:36.439] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:56:0) after 1m0s
[08:39:36.459] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:56:0)
[08:39:36.459] Timer tick, asking Buildbucket for the build status
[08:39:36.539] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:36.539] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:57:0) after 1m0s
[08:40:36.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:57:0)
[08:40:36.563] Timer tick, asking Buildbucket for the build status
[08:40:36.658] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:36.658] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:58:0) after 1m0s
[08:41:36.678] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:58:0)
[08:41:36.678] Timer tick, asking Buildbucket for the build status
[08:41:36.767] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:36.767] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:59:0) after 1m0s
[08:42:36.790] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:59:0)
[08:42:36.790] Timer tick, asking Buildbucket for the build status
[08:42:36.900] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:36.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:60:0) after 1m0s
[08:43:36.919] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:60:0)
[08:43:36.919] Timer tick, asking Buildbucket for the build status
[08:43:36.981] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:36.981] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:61:0) after 1m0s
[08:44:37.007] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:61:0)
[08:44:37.007] Timer tick, asking Buildbucket for the build status
[08:44:37.136] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:37.136] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:62:0) after 1m0s
[08:45:37.161] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:62:0)
[08:45:37.161] Timer tick, asking Buildbucket for the build status
[08:45:37.240] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:37.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:63:0) after 1m0s
[08:46:37.258] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:63:0)
[08:46:37.258] Timer tick, asking Buildbucket for the build status
[08:46:37.334] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:37.334] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:64:0) after 1m0s
[08:47:37.355] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:64:0)
[08:47:37.355] Timer tick, asking Buildbucket for the build status
[08:47:37.454] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:37.454] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:65:0) after 1m0s
[08:48:37.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:65:0)
[08:48:37.503] Timer tick, asking Buildbucket for the build status
[08:48:37.576] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:37.576] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:66:0) after 1m0s
[08:49:37.598] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:66:0)
[08:49:37.598] Timer tick, asking Buildbucket for the build status
[08:49:37.780] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:37.780] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:67:0) after 1m0s
[08:50:37.805] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:67:0)
[08:50:37.805] Timer tick, asking Buildbucket for the build status
[08:50:37.863] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:37.863] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:68:0) after 1m0s
[08:51:37.883] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:68:0)
[08:51:37.883] Timer tick, asking Buildbucket for the build status
[08:51:37.933] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:37.933] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:69:0) after 1m0s
[08:52:37.951] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:69:0)
[08:52:37.951] Timer tick, asking Buildbucket for the build status
[08:52:38.029] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:38.029] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:70:0) after 1m0s
[08:53:38.050] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:70:0)
[08:53:38.050] Timer tick, asking Buildbucket for the build status
[08:53:38.103] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:38.103] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:71:0) after 1m0s
[08:54:38.128] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:71:0)
[08:54:38.128] Timer tick, asking Buildbucket for the build status
[08:54:38.188] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:38.188] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:72:0) after 1m0s
[08:55:38.441] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:72:0)
[08:55:38.441] Timer tick, asking Buildbucket for the build status
[08:55:38.499] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:38.499] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:73:0) after 1m0s
[08:56:38.594] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:73:0)
[08:56:38.594] Timer tick, asking Buildbucket for the build status
[08:56:38.713] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:38.713] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:74:0) after 1m0s
[08:57:38.750] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:74:0)
[08:57:38.750] Timer tick, asking Buildbucket for the build status
[08:57:38.857] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:38.857] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:75:0) after 1m0s
[08:58:38.877] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:75:0)
[08:58:38.877] Timer tick, asking Buildbucket for the build status
[08:58:38.948] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:38.948] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:76:0) after 1m0s
[08:59:38.970] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:76:0)
[08:59:38.970] Timer tick, asking Buildbucket for the build status
[08:59:39.023] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:39.023] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:77:0) after 1m0s
[09:00:39.050] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:77:0)
[09:00:39.050] Timer tick, asking Buildbucket for the build status
[09:00:39.234] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:39.234] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:78:0) after 1m0s
[09:01:39.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:78:0)
[09:01:39.275] Timer tick, asking Buildbucket for the build status
[09:01:39.326] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:39.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:79:0) after 1m0s
[09:02:39.404] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:79:0)
[09:02:39.404] Timer tick, asking Buildbucket for the build status
[09:02:39.636] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:39.636] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:80:0) after 1m0s
[09:03:39.660] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:80:0)
[09:03:39.660] Timer tick, asking Buildbucket for the build status
[09:03:39.723] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:39.723] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:81:0) after 1m0s
[09:04:39.746] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:81:0)
[09:04:39.746] Timer tick, asking Buildbucket for the build status
[09:04:39.858] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:39.858] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:82:0) after 1m0s
[09:05:39.879] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:82:0)
[09:05:39.879] Timer tick, asking Buildbucket for the build status
[09:05:39.975] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:39.975] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:83:0) after 1m0s
[09:06:39.996] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:83:0)
[09:06:39.996] Timer tick, asking Buildbucket for the build status
[09:06:40.047] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:40.047] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:84:0) after 1m0s
[09:07:40.070] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:84:0)
[09:07:40.070] Timer tick, asking Buildbucket for the build status
[09:07:43.432] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:43.432] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:85:0) after 1m0s
[09:08:43.457] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:85:0)
[09:08:43.457] Timer tick, asking Buildbucket for the build status
[09:08:43.591] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:43.591] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:86:0) after 1m0s
[09:09:43.616] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:86:0)
[09:09:43.616] Timer tick, asking Buildbucket for the build status
[09:09:43.811] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:43.811] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:87:0) after 1m0s
[09:10:43.838] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:87:0)
[09:10:43.838] Timer tick, asking Buildbucket for the build status
[09:10:43.896] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:43.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:88:0) after 1m0s
[09:11:43.916] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:88:0)
[09:11:43.916] Timer tick, asking Buildbucket for the build status
[09:11:44.038] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:44.038] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:89:0) after 1m0s
[09:12:44.062] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:89:0)
[09:12:44.062] Timer tick, asking Buildbucket for the build status
[09:12:44.116] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:44.116] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:90:0) after 1m0s
[09:13:44.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:90:0)
[09:13:44.137] Timer tick, asking Buildbucket for the build status
[09:13:44.264] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:44.264] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:91:0) after 1m0s
[09:14:44.288] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:91:0)
[09:14:44.288] Timer tick, asking Buildbucket for the build status
[09:14:44.340] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:44.340] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:92:0) after 1m0s
[09:15:44.365] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:92:0)
[09:15:44.365] Timer tick, asking Buildbucket for the build status
[09:15:44.495] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:44.495] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:93:0) after 1m0s
[09:16:44.518] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:93:0)
[09:16:44.518] Timer tick, asking Buildbucket for the build status
[09:16:44.949] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:44.949] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:94:0) after 1m0s
[09:17:44.974] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:94:0)
[09:17:44.974] Timer tick, asking Buildbucket for the build status
[09:17:45.022] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:45.022] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:95:0) after 1m0s
[09:18:45.048] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:95:0)
[09:18:45.048] Timer tick, asking Buildbucket for the build status
[09:18:45.106] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:45.106] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:96:0) after 1m0s
[09:19:45.148] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:96:0)
[09:19:45.148] Timer tick, asking Buildbucket for the build status
[09:19:45.213] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:45.213] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:97:0) after 1m0s
[09:20:45.239] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:97:0)
[09:20:45.239] Timer tick, asking Buildbucket for the build status
[09:20:45.348] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:45.348] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:98:0) after 1m0s
[09:21:45.371] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:98:0)
[09:21:45.371] Timer tick, asking Buildbucket for the build status
[09:21:45.416] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:45.416] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:99:0) after 1m0s
[09:22:45.440] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:99:0)
[09:22:45.440] Timer tick, asking Buildbucket for the build status
[09:22:45.603] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:45.603] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:100:0) after 1m0s
[09:23:45.720] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:100:0)
[09:23:45.720] Timer tick, asking Buildbucket for the build status
[09:23:46.029] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:46.029] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:101:0) after 1m0s
[09:24:46.104] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:101:0)
[09:24:46.104] Timer tick, asking Buildbucket for the build status
[09:24:46.178] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:46.178] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:102:0) after 1m0s
[09:25:46.199] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:102:0)
[09:25:46.199] Timer tick, asking Buildbucket for the build status
[09:25:46.313] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:46.313] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:103:0) after 1m0s
[09:26:46.362] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:103:0)
[09:26:46.362] Timer tick, asking Buildbucket for the build status
[09:26:46.416] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:46.416] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:104:0) after 1m0s
[09:27:46.460] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:104:0)
[09:27:46.460] Timer tick, asking Buildbucket for the build status
[09:27:46.521] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:46.521] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:105:0) after 1m0s
[09:28:46.542] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:105:0)
[09:28:46.542] Timer tick, asking Buildbucket for the build status
[09:28:46.653] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:46.653] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:106:0) after 1m0s
[09:29:46.678] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:106:0)
[09:29:46.678] Timer tick, asking Buildbucket for the build status
[09:29:46.735] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:46.735] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:107:0) after 1m0s
[09:30:46.799] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:107:0)
[09:30:46.799] Timer tick, asking Buildbucket for the build status
[09:30:46.868] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:46.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:108:0) after 1m0s
[09:31:46.907] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:108:0)
[09:31:46.907] Timer tick, asking Buildbucket for the build status
[09:31:46.947] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:46.947] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:109:0) after 1m0s
[09:32:46.970] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:109:0)
[09:32:46.970] Timer tick, asking Buildbucket for the build status
[09:32:47.070] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:47.070] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:110:0) after 1m0s
[09:33:47.097] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:110:0)
[09:33:47.097] Timer tick, asking Buildbucket for the build status
[09:33:47.139] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:47.139] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:111:0) after 1m0s
[09:34:47.176] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:111:0)
[09:34:47.176] Timer tick, asking Buildbucket for the build status
[09:34:47.227] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:47.227] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:112:0) after 1m0s
[09:35:47.254] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:112:0)
[09:35:47.255] Timer tick, asking Buildbucket for the build status
[09:35:47.433] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:47.433] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:113:0) after 1m0s
[09:36:47.471] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:113:0)
[09:36:47.471] Timer tick, asking Buildbucket for the build status
[09:36:47.563] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:47.563] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:114:0) after 1m0s
[09:37:47.594] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:114:0)
[09:37:47.594] Timer tick, asking Buildbucket for the build status
[09:37:47.689] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:47.689] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:115:0) after 1m0s
[09:38:47.712] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:115:0)
[09:38:47.712] Timer tick, asking Buildbucket for the build status
[09:38:47.803] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:47.803] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:116:0) after 1m0s
[09:39:47.828] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:116:0)
[09:39:47.828] Timer tick, asking Buildbucket for the build status
[09:39:47.904] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:47.904] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:117:0) after 1m0s
[09:40:47.945] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:117:0)
[09:40:47.945] Timer tick, asking Buildbucket for the build status
[09:40:48.139] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:48.139] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:118:0) after 1m0s
[09:41:48.164] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:118:0)
[09:41:48.164] Timer tick, asking Buildbucket for the build status
[09:41:48.256] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:48.256] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:119:0) after 1m0s
[09:42:48.381] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:119:0)
[09:42:48.381] Timer tick, asking Buildbucket for the build status
[09:42:48.456] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:48.456] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:120:0) after 1m0s
[09:43:48.546] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:120:0)
[09:43:48.546] Timer tick, asking Buildbucket for the build status
[09:43:48.644] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:48.644] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:121:0) after 1m0s
[09:44:48.667] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:121:0)
[09:44:48.667] Timer tick, asking Buildbucket for the build status
[09:44:48.718] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:48.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:122:0) after 1m0s
[09:45:48.761] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:122:0)
[09:45:48.761] Timer tick, asking Buildbucket for the build status
[09:45:48.862] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:48.862] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:123:0) after 1m0s
[09:46:48.885] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:123:0)
[09:46:48.885] Timer tick, asking Buildbucket for the build status
[09:46:48.956] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:48.956] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:124:0) after 1m0s
[09:47:48.980] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:124:0)
[09:47:48.980] Timer tick, asking Buildbucket for the build status
[09:47:49.039] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:49.039] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:125:0) after 1m0s
[09:48:49.060] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:125:0)
[09:48:49.060] Timer tick, asking Buildbucket for the build status
[09:48:49.124] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:49.124] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:126:0) after 1m0s
[09:49:49.160] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:126:0)
[09:49:49.160] Timer tick, asking Buildbucket for the build status
[09:49:49.346] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:49.346] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:127:0) after 1m0s
[09:50:49.407] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:127:0)
[09:50:49.407] Timer tick, asking Buildbucket for the build status
[09:50:49.524] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:49.524] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:128:0) after 1m0s
[09:51:49.546] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:128:0)
[09:51:49.546] Timer tick, asking Buildbucket for the build status
[09:51:49.824] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:49.824] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:129:0) after 1m0s
[09:52:49.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:129:0)
[09:52:49.854] Timer tick, asking Buildbucket for the build status
[09:52:49.971] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:49.971] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:130:0) after 1m0s
[09:53:50.073] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:130:0)
[09:53:50.073] Timer tick, asking Buildbucket for the build status
[09:53:50.187] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:50.187] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:131:0) after 1m0s
[09:54:50.207] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:131:0)
[09:54:50.207] Timer tick, asking Buildbucket for the build status
[09:54:50.326] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:50.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:132:0) after 1m0s
[09:55:50.356] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:132:0)
[09:55:50.356] Timer tick, asking Buildbucket for the build status
[09:55:50.634] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:50.634] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:133:0) after 1m0s
[09:56:50.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:133:0)
[09:56:50.658] Timer tick, asking Buildbucket for the build status
[09:56:50.811] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:50.811] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:134:0) after 1m0s
[09:57:50.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:134:0)
[09:57:50.837] Timer tick, asking Buildbucket for the build status
[09:57:50.939] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:50.939] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:135:0) after 1m0s
[09:58:51.001] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:135:0)
[09:58:51.001] Timer tick, asking Buildbucket for the build status
[09:58:51.252] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:51.252] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:136:0) after 1m0s
[09:59:51.324] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:136:0)
[09:59:51.324] Timer tick, asking Buildbucket for the build status
[09:59:51.453] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:51.453] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:137:0) after 1m0s
[10:00:51.550] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:137:0)
[10:00:51.550] Timer tick, asking Buildbucket for the build status
[10:00:51.800] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:51.800] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:138:0) after 1m0s
[10:01:51.886] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:138:0)
[10:01:51.886] Timer tick, asking Buildbucket for the build status
[10:01:51.942] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:51.942] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:139:0) after 1m0s
[10:02:51.967] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:139:0)
[10:02:51.967] Timer tick, asking Buildbucket for the build status
[10:02:52.081] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:52.081] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:140:0) after 1m0s
[10:03:52.105] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:140:0)
[10:03:52.106] Timer tick, asking Buildbucket for the build status
[10:03:52.621] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:52.621] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:141:0) after 1m0s
[10:04:52.654] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:141:0)
[10:04:52.654] Timer tick, asking Buildbucket for the build status
[10:04:52.714] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:52.714] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:142:0) after 1m0s
[10:05:52.737] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:142:0)
[10:05:52.737] Timer tick, asking Buildbucket for the build status
[10:05:52.795] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:52.795] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:143:0) after 1m0s
[10:06:52.829] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:143:0)
[10:06:52.829] Timer tick, asking Buildbucket for the build status
[10:06:53.101] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:53.101] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:144:0) after 1m0s
[10:07:53.133] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:144:0)
[10:07:53.133] Timer tick, asking Buildbucket for the build status
[10:07:53.265] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:53.265] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:145:0) after 1m0s
[10:08:53.314] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:145:0)
[10:08:53.314] Timer tick, asking Buildbucket for the build status
[10:08:53.345] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:53.345] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:146:0) after 1m0s
[10:09:53.422] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:146:0)
[10:09:53.422] Timer tick, asking Buildbucket for the build status
[10:09:53.510] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:53.510] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:147:0) after 1m0s
[10:10:53.544] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:147:0)
[10:10:53.544] Timer tick, asking Buildbucket for the build status
[10:10:53.694] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:53.694] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:148:0) after 1m0s
[10:11:53.718] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:148:0)
[10:11:53.718] Timer tick, asking Buildbucket for the build status
[10:11:53.975] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:53.975] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:149:0) after 1m0s
[10:12:53.995] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:149:0)
[10:12:53.995] Timer tick, asking Buildbucket for the build status
[10:12:54.034] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:54.034] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:150:0) after 1m0s
[10:13:54.066] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:150:0)
[10:13:54.066] Timer tick, asking Buildbucket for the build status
[10:13:54.476] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:54.476] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:151:0) after 1m0s
[10:14:54.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:151:0)
[10:14:54.503] Timer tick, asking Buildbucket for the build status
[10:14:54.608] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:54.608] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:152:0) after 1m0s
[10:15:54.629] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:152:0)
[10:15:54.629] Timer tick, asking Buildbucket for the build status
[10:15:54.760] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:54.760] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:153:0) after 1m0s
[10:16:54.846] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:153:0)
[10:16:54.846] Timer tick, asking Buildbucket for the build status
[10:16:55.002] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:55.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:154:0) after 1m0s
[10:17:55.023] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:154:0)
[10:17:55.023] Timer tick, asking Buildbucket for the build status
[10:17:55.086] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:55.086] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:155:0) after 1m0s
[10:18:55.110] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:155:0)
[10:18:55.110] Timer tick, asking Buildbucket for the build status
[10:18:55.172] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:55.172] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:156:0) after 1m0s
[10:19:55.193] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:156:0)
[10:19:55.193] Timer tick, asking Buildbucket for the build status
[10:19:55.267] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:55.267] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:157:0) after 1m0s
[10:20:55.292] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:157:0)
[10:20:55.292] Timer tick, asking Buildbucket for the build status
[10:20:55.630] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:55.630] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:158:0) after 1m0s
[10:21:55.653] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:158:0)
[10:21:55.653] Timer tick, asking Buildbucket for the build status
[10:21:55.815] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:55.815] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:159:0) after 1m0s
[10:22:55.840] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:159:0)
[10:22:55.840] Timer tick, asking Buildbucket for the build status
[10:22:55.875] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:55.875] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:160:0) after 1m0s
[10:23:55.908] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:160:0)
[10:23:55.908] Timer tick, asking Buildbucket for the build status
[10:23:56.077] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:56.077] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:161:0) after 1m0s
[10:24:56.102] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:161:0)
[10:24:56.102] Timer tick, asking Buildbucket for the build status
[10:24:56.210] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:56.211] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:162:0) after 1m0s
[10:25:56.240] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:162:0)
[10:25:56.240] Timer tick, asking Buildbucket for the build status
[10:25:56.350] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:56.350] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:163:0) after 1m0s
[10:26:56.372] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:163:0)
[10:26:56.372] Timer tick, asking Buildbucket for the build status
[10:26:56.453] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:56.453] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:164:0) after 1m0s
[10:27:56.476] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:164:0)
[10:27:56.476] Timer tick, asking Buildbucket for the build status
[10:27:56.631] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:56.631] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:165:0) after 1m0s
[10:28:56.734] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:165:0)
[10:28:56.734] Timer tick, asking Buildbucket for the build status
[10:28:56.876] Build 8942039171998126144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:56.876] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9107469234097730512:166:0) after 1m0s
[10:29:56.856] Received PubSub notification, asking Buildbucket for the build status
[10:29:56.938] Build 8942039171998126144: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[10:29:56.938] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1530613795030650",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1530603927574010",
"experimental": true,
"failure_reason": "INFRA_FAILURE",
"id": "8942039171998126144",
"parameters_json": "{\"builder_name\": \"Deterministic Android (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fdf6a8b74b61a022c931d99100939b699314b85d\"}}",
"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/8942039171998126144/+/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\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"030b88a205c9ce9a82d68798bfaa059fd55216cd\", \"got_swarming_client_revision\": \"9a518d097dca20b7b00ce3bdfc5d418ccc79893a\", \"got_revision\": \"fdf6a8b74b61a022c931d99100939b699314b85d\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#23809}\", \"$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@{#572139}\", \"got_src_revision\": \"fdf6a8b74b61a022c931d99100939b699314b85d\", \"got_revision_cp\": \"refs/heads/master@{#572139}\", \"branch\": \"refs/heads/master\", \"revision\": \"fdf6a8b74b61a022c931d99100939b699314b85d\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Deterministic Android (dbg)\", \"got_webrtc_revision\": \"0ea751539e3a2e00d0449942b4c6993512e37b64\", \"mastername\": \"chromium.android\", \"got_angle_revision\": \"92da844eb7543d2ac39fe2ae9c62edd3a3b6891f\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1530603927574010, \"tags\": [\"builder:Deterministic Android (dbg)\", \"buildset:commit/git/fdf6a8b74b61a022c931d99100939b699314b85d\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fdf6a8b74b61a022c931d99100939b699314b85d\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9107469234097730512\", \"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\": \"8942039171998126144\"}}, \"got_v8_revision\": \"7ce703efb495d2227b92777f8bb5e7b1c1823497\", \"got_v8_revision_cp\": \"refs/heads/6.9.278@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": true, \"is_luci\": true}, \"buildnumber\": 1773, \"path_config\": \"generic\", \"bot_id\": \"swarm629-c4\", \"got_buildtools_revision\": \"0dd5c6f980d22be96b728155249df2da355989d9\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1530603961898880",
"status": "COMPLETED",
"status_changed_ts": "1530613796420960",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android (dbg)/1773",
"builder:Deterministic Android (dbg)",
"buildset:commit/git/fdf6a8b74b61a022c931d99100939b699314b85d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fdf6a8b74b61a022c931d99100939b699314b85d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9107469234097730512",
"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)/1773",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8942039171998126144",
"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/fdf6a8b74b61a022c931d99100939b699314b85d",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fdf6a8b74b61a022c931d99100939b699314b85d",
"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/8942039171998126144/+/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:9107469234097730512",
"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:761be570b9ddc8b12cd9bf031b7ba136a1879f33",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e77ec022b9ac710",
"user_agent:luci-scheduler"
],
"updated_ts": "1530613796469000",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Deterministic Android (dbg)/1773",
"utcnow_ts": "1530613796921030"
}
}
[10:29:56.938] Invocation finished in 2h44m30.749930439s with status FAILED