[04:37:48.173] New invocation is queued and will start shortly
[04:37:49.256] Starting the invocation (attempt 1)
[04:37:49.292] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:37:49.292] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:37:49.292] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019692578555885376",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"bad2a9914bc356c6602361bf21c767ec010e7213\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9019692578555885376",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/bad2a9914bc356c6602361bf21c767ec010e7213",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bad2a9914bc356c6602361bf21c767ec010e7213",
"gitiles_ref:refs/heads/master"
]
}
[04:37:50.096] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614314269389472",
"id": "8854262516619670736",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bad2a9914bc356c6602361bf21c767ec010e7213\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614314269813344",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/8017",
"builder:android-bfcache-rel",
"buildset:commit/git/bad2a9914bc356c6602361bf21c767ec010e7213",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bad2a9914bc356c6602361bf21c767ec010e7213",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019692578555885376",
"scheduler_job_id:chromium/android-bfcache-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854262516619670736/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1614314269813688",
"url": "https://ci.chromium.org/b/8854262516619670736",
"utcnow_ts": "1614314270081498"
}
}
[04:37:50.096] Task URL: https://ci.chromium.org/b/8854262516619670736
[04:37:50.096] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:2:0) after 1m0s
[04:37:53.086] Received PubSub notification, asking Buildbucket for the build status
[04:37:53.197] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:50.139] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:2:0)
[04:38:50.139] Timer tick, asking Buildbucket for the build status
[04:38:50.710] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:50.710] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:4:0) after 1m0s
[04:39:50.852] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:4:0)
[04:39:50.852] Timer tick, asking Buildbucket for the build status
[04:39:50.959] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:50.959] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:5:0) after 1m0s
[04:40:50.997] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:5:0)
[04:40:50.997] Timer tick, asking Buildbucket for the build status
[04:40:51.071] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:51.071] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:6:0) after 1m0s
[04:41:51.086] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:6:0)
[04:41:51.086] Timer tick, asking Buildbucket for the build status
[04:41:51.613] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:51.613] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:7:0) after 1m0s
[04:42:51.660] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:7:0)
[04:42:51.660] Timer tick, asking Buildbucket for the build status
[04:42:51.735] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:51.735] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:8:0) after 1m0s
[04:43:51.817] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:8:0)
[04:43:51.817] Timer tick, asking Buildbucket for the build status
[04:43:51.980] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:51.980] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:9:0) after 1m0s
[04:44:52.032] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:9:0)
[04:44:52.032] Timer tick, asking Buildbucket for the build status
[04:44:52.101] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:52.101] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:10:0) after 1m0s
[04:45:52.117] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:10:0)
[04:45:52.117] Timer tick, asking Buildbucket for the build status
[04:45:52.216] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:52.216] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:11:0) after 1m0s
[04:46:52.221] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:11:0)
[04:46:52.221] Timer tick, asking Buildbucket for the build status
[04:46:52.688] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:52.688] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:12:0) after 1m0s
[04:47:52.739] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:12:0)
[04:47:52.739] Timer tick, asking Buildbucket for the build status
[04:47:52.835] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:52.835] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:13:0) after 1m0s
[04:48:52.804] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:13:0)
[04:48:52.804] Timer tick, asking Buildbucket for the build status
[04:48:52.895] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:52.895] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:14:0) after 1m0s
[04:49:52.869] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:14:0)
[04:49:52.869] Timer tick, asking Buildbucket for the build status
[04:49:52.991] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:52.991] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:15:0) after 1m0s
[04:50:53.056] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:15:0)
[04:50:53.056] Timer tick, asking Buildbucket for the build status
[04:50:53.134] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:53.134] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:16:0) after 1m0s
[04:51:53.199] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:16:0)
[04:51:53.199] Timer tick, asking Buildbucket for the build status
[04:51:53.313] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:53.313] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:17:0) after 1m0s
[04:52:53.391] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:17:0)
[04:52:53.391] Timer tick, asking Buildbucket for the build status
[04:52:53.496] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:53.496] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:18:0) after 1m0s
[04:53:53.563] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:18:0)
[04:53:53.563] Timer tick, asking Buildbucket for the build status
[04:53:53.816] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:53.816] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:19:0) after 1m0s
[04:54:53.832] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:19:0)
[04:54:53.832] Timer tick, asking Buildbucket for the build status
[04:54:54.051] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:54.051] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:20:0) after 1m0s
[04:55:54.104] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:20:0)
[04:55:54.104] Timer tick, asking Buildbucket for the build status
[04:55:54.295] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:54.295] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:21:0) after 1m0s
[04:56:54.330] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:21:0)
[04:56:54.330] Timer tick, asking Buildbucket for the build status
[04:56:54.611] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:54.611] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:22:0) after 1m0s
[04:57:54.664] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:22:0)
[04:57:54.664] Timer tick, asking Buildbucket for the build status
[04:57:55.096] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:55.096] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:23:0) after 1m0s
[04:58:55.188] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:23:0)
[04:58:55.188] Timer tick, asking Buildbucket for the build status
[04:58:55.264] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:55.264] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:24:0) after 1m0s
[04:59:55.287] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:24:0)
[04:59:55.287] Timer tick, asking Buildbucket for the build status
[04:59:55.373] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:55.373] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:25:0) after 1m0s
[05:00:55.400] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:25:0)
[05:00:55.400] Timer tick, asking Buildbucket for the build status
[05:00:55.492] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:55.492] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:26:0) after 1m0s
[05:01:55.557] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:26:0)
[05:01:55.557] Timer tick, asking Buildbucket for the build status
[05:01:55.656] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:55.656] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:27:0) after 1m0s
[05:02:55.667] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:27:0)
[05:02:55.667] Timer tick, asking Buildbucket for the build status
[05:02:55.914] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:55.914] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:28:0) after 1m0s
[05:03:55.949] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:28:0)
[05:03:55.949] Timer tick, asking Buildbucket for the build status
[05:03:56.074] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:56.074] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:29:0) after 1m0s
[05:04:56.088] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:29:0)
[05:04:56.088] Timer tick, asking Buildbucket for the build status
[05:04:56.218] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:56.218] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:30:0) after 1m0s
[05:05:56.261] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:30:0)
[05:05:56.261] Timer tick, asking Buildbucket for the build status
[05:05:56.345] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:56.345] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:31:0) after 1m0s
[05:06:56.387] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:31:0)
[05:06:56.387] Timer tick, asking Buildbucket for the build status
[05:06:56.462] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:56.462] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:32:0) after 1m0s
[05:07:56.541] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:32:0)
[05:07:56.541] Timer tick, asking Buildbucket for the build status
[05:07:56.664] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:56.664] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:33:0) after 1m0s
[05:08:56.670] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:33:0)
[05:08:56.670] Timer tick, asking Buildbucket for the build status
[05:08:56.916] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:56.916] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:34:0) after 1m0s
[05:09:56.964] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:34:0)
[05:09:56.964] Timer tick, asking Buildbucket for the build status
[05:09:57.055] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:57.055] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:35:0) after 1m0s
[05:10:57.075] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:35:0)
[05:10:57.075] Timer tick, asking Buildbucket for the build status
[05:10:57.473] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:57.473] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:36:0) after 1m0s
[05:11:57.503] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:36:0)
[05:11:57.503] Timer tick, asking Buildbucket for the build status
[05:11:57.758] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:57.758] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:37:0) after 1m0s
[05:12:57.802] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:37:0)
[05:12:57.802] Timer tick, asking Buildbucket for the build status
[05:12:57.913] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:57.913] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:38:0) after 1m0s
[05:13:58.003] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:38:0)
[05:13:58.003] Timer tick, asking Buildbucket for the build status
[05:13:58.108] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:58.108] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:39:0) after 1m0s
[05:14:58.262] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:39:0)
[05:14:58.262] Timer tick, asking Buildbucket for the build status
[05:14:58.353] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:58.353] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:40:0) after 1m0s
[05:15:58.421] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:40:0)
[05:15:58.421] Timer tick, asking Buildbucket for the build status
[05:15:58.653] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:58.653] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:41:0) after 1m0s
[05:16:58.631] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:41:0)
[05:16:58.631] Timer tick, asking Buildbucket for the build status
[05:16:58.710] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:58.710] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:42:0) after 1m0s
[05:17:58.752] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:42:0)
[05:17:58.752] Timer tick, asking Buildbucket for the build status
[05:17:58.851] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:58.851] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:43:0) after 1m0s
[05:18:58.872] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:43:0)
[05:18:58.872] Timer tick, asking Buildbucket for the build status
[05:18:58.940] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:58.940] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:44:0) after 1m0s
[05:19:58.932] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:44:0)
[05:19:58.932] Timer tick, asking Buildbucket for the build status
[05:19:59.007] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:59.007] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:45:0) after 1m0s
[05:20:58.983] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:45:0)
[05:20:58.983] Timer tick, asking Buildbucket for the build status
[05:20:59.474] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:59.474] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:46:0) after 1m0s
[05:21:59.504] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:46:0)
[05:21:59.504] Timer tick, asking Buildbucket for the build status
[05:21:59.573] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:59.573] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:47:0) after 1m0s
[05:22:59.611] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:47:0)
[05:22:59.611] Timer tick, asking Buildbucket for the build status
[05:22:59.707] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:59.707] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:48:0) after 1m0s
[05:23:59.732] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:48:0)
[05:23:59.732] Timer tick, asking Buildbucket for the build status
[05:23:59.800] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:59.800] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:49:0) after 1m0s
[05:24:59.818] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:49:0)
[05:24:59.818] Timer tick, asking Buildbucket for the build status
[05:25:00.074] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:00.074] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:50:0) after 1m0s
[05:26:00.095] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:50:0)
[05:26:00.095] Timer tick, asking Buildbucket for the build status
[05:26:00.425] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:00.425] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:51:0) after 1m0s
[05:27:00.445] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:51:0)
[05:27:00.445] Timer tick, asking Buildbucket for the build status
[05:27:00.522] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:00.522] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:52:0) after 1m0s
[05:28:01.003] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:52:0)
[05:28:01.003] Timer tick, asking Buildbucket for the build status
[05:28:01.148] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:01.148] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:53:0) after 1m0s
[05:29:01.196] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:53:0)
[05:29:01.196] Timer tick, asking Buildbucket for the build status
[05:29:01.265] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:01.265] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:54:0) after 1m0s
[05:30:01.283] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:54:0)
[05:30:01.283] Timer tick, asking Buildbucket for the build status
[05:30:01.390] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:01.390] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:55:0) after 1m0s
[05:31:01.487] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:55:0)
[05:31:01.487] Timer tick, asking Buildbucket for the build status
[05:31:01.719] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:01.719] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:56:0) after 1m0s
[05:32:01.940] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:56:0)
[05:32:01.940] Timer tick, asking Buildbucket for the build status
[05:32:02.292] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:02.292] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:57:0) after 1m0s
[05:33:02.311] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:57:0)
[05:33:02.311] Timer tick, asking Buildbucket for the build status
[05:33:02.420] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:02.420] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:58:0) after 1m0s
[05:34:02.594] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:58:0)
[05:34:02.594] Timer tick, asking Buildbucket for the build status
[05:34:02.828] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:02.828] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:59:0) after 1m0s
[05:35:02.798] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:59:0)
[05:35:02.798] Timer tick, asking Buildbucket for the build status
[05:35:02.868] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:02.868] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:60:0) after 1m0s
[05:36:03.099] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:60:0)
[05:36:03.099] Timer tick, asking Buildbucket for the build status
[05:36:03.170] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:03.170] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:61:0) after 1m0s
[05:37:03.367] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:61:0)
[05:37:03.367] Timer tick, asking Buildbucket for the build status
[05:37:03.520] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:03.520] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:62:0) after 1m0s
[05:38:03.603] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:62:0)
[05:38:03.603] Timer tick, asking Buildbucket for the build status
[05:38:04.004] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:04.004] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:63:0) after 1m0s
[05:39:04.227] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:63:0)
[05:39:04.227] Timer tick, asking Buildbucket for the build status
[05:39:04.426] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:04.426] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:64:0) after 1m0s
[05:40:04.542] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:64:0)
[05:40:04.542] Timer tick, asking Buildbucket for the build status
[05:40:04.622] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:04.622] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:65:0) after 1m0s
[05:41:04.720] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:65:0)
[05:41:04.720] Timer tick, asking Buildbucket for the build status
[05:41:04.812] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:04.812] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:66:0) after 1m0s
[05:42:04.929] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:66:0)
[05:42:04.929] Timer tick, asking Buildbucket for the build status
[05:42:05.101] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:05.101] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:67:0) after 1m0s
[05:43:05.118] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:67:0)
[05:43:05.118] Timer tick, asking Buildbucket for the build status
[05:43:05.341] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:05.341] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:68:0) after 1m0s
[05:44:05.357] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:68:0)
[05:44:05.357] Timer tick, asking Buildbucket for the build status
[05:44:05.572] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:05.572] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:69:0) after 1m0s
[05:45:05.580] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:69:0)
[05:45:05.580] Timer tick, asking Buildbucket for the build status
[05:45:05.999] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:05.999] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:70:0) after 1m0s
[05:46:06.000] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:70:0)
[05:46:06.000] Timer tick, asking Buildbucket for the build status
[05:46:06.376] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:06.376] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:71:0) after 1m0s
[05:47:06.457] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:71:0)
[05:47:06.457] Timer tick, asking Buildbucket for the build status
[05:47:06.719] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:06.719] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:72:0) after 1m0s
[05:48:06.762] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:72:0)
[05:48:06.762] Timer tick, asking Buildbucket for the build status
[05:48:06.934] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:06.934] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:73:0) after 1m0s
[05:49:06.953] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:73:0)
[05:49:06.953] Timer tick, asking Buildbucket for the build status
[05:49:07.024] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:07.024] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:74:0) after 1m0s
[05:50:07.125] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:74:0)
[05:50:07.125] Timer tick, asking Buildbucket for the build status
[05:50:07.204] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:07.204] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:75:0) after 1m0s
[05:51:07.290] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:75:0)
[05:51:07.290] Timer tick, asking Buildbucket for the build status
[05:51:07.412] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:07.412] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:76:0) after 1m0s
[05:52:07.504] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:76:0)
[05:52:07.504] Timer tick, asking Buildbucket for the build status
[05:52:07.591] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:07.591] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:77:0) after 1m0s
[05:53:07.773] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:77:0)
[05:53:07.773] Timer tick, asking Buildbucket for the build status
[05:53:07.854] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:07.854] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:78:0) after 1m0s
[05:54:07.968] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:78:0)
[05:54:07.968] Timer tick, asking Buildbucket for the build status
[05:54:08.038] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:08.038] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:79:0) after 1m0s
[05:55:08.057] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:79:0)
[05:55:08.057] Timer tick, asking Buildbucket for the build status
[05:55:08.256] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:08.256] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:80:0) after 1m0s
[05:56:08.231] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:80:0)
[05:56:08.231] Timer tick, asking Buildbucket for the build status
[05:56:08.388] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:08.388] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:81:0) after 1m0s
[05:57:08.461] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:81:0)
[05:57:08.461] Timer tick, asking Buildbucket for the build status
[05:57:08.531] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:08.531] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:82:0) after 1m0s
[05:58:08.532] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:82:0)
[05:58:08.532] Timer tick, asking Buildbucket for the build status
[05:58:08.855] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:08.855] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:83:0) after 1m0s
[05:59:08.901] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:83:0)
[05:59:08.901] Timer tick, asking Buildbucket for the build status
[05:59:08.973] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:08.973] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:84:0) after 1m0s
[06:00:09.070] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:84:0)
[06:00:09.070] Timer tick, asking Buildbucket for the build status
[06:00:09.166] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:09.166] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:85:0) after 1m0s
[06:01:11.754] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:85:0)
[06:01:11.754] Timer tick, asking Buildbucket for the build status
[06:01:11.853] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:11.853] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:86:0) after 1m0s
[06:02:11.824] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:86:0)
[06:02:11.824] Timer tick, asking Buildbucket for the build status
[06:02:12.152] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:12.152] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:87:0) after 1m0s
[06:03:12.205] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:87:0)
[06:03:12.205] Timer tick, asking Buildbucket for the build status
[06:03:12.566] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:12.566] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:88:0) after 1m0s
[06:04:12.626] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:88:0)
[06:04:12.626] Timer tick, asking Buildbucket for the build status
[06:04:12.692] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:12.692] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:89:0) after 1m0s
[06:05:12.852] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:89:0)
[06:05:12.852] Timer tick, asking Buildbucket for the build status
[06:05:12.988] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:12.988] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:90:0) after 1m0s
[06:06:13.018] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:90:0)
[06:06:13.018] Timer tick, asking Buildbucket for the build status
[06:06:13.127] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:13.127] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:91:0) after 1m0s
[06:07:13.131] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:91:0)
[06:07:13.131] Timer tick, asking Buildbucket for the build status
[06:07:13.245] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:13.245] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:92:0) after 1m0s
[06:08:13.278] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:92:0)
[06:08:13.278] Timer tick, asking Buildbucket for the build status
[06:08:13.369] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:13.369] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:93:0) after 1m0s
[06:09:13.449] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:93:0)
[06:09:13.449] Timer tick, asking Buildbucket for the build status
[06:09:13.580] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:13.580] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:94:0) after 1m0s
[06:10:13.655] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:94:0)
[06:10:13.656] Timer tick, asking Buildbucket for the build status
[06:10:13.724] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:13.724] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:95:0) after 1m0s
[06:11:13.797] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:95:0)
[06:11:13.797] Timer tick, asking Buildbucket for the build status
[06:11:14.096] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:14.096] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:96:0) after 1m0s
[06:12:14.147] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:96:0)
[06:12:14.147] Timer tick, asking Buildbucket for the build status
[06:12:14.314] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:14.314] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:97:0) after 1m0s
[06:13:14.347] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:97:0)
[06:13:14.347] Timer tick, asking Buildbucket for the build status
[06:13:14.712] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:14.712] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:98:0) after 1m0s
[06:14:14.717] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:98:0)
[06:14:14.717] Timer tick, asking Buildbucket for the build status
[06:14:14.821] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:14.821] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:99:0) after 1m0s
[06:15:14.902] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:99:0)
[06:15:14.902] Timer tick, asking Buildbucket for the build status
[06:15:15.035] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:15.035] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:100:0) after 1m0s
[06:16:15.143] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:100:0)
[06:16:15.143] Timer tick, asking Buildbucket for the build status
[06:16:15.259] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:15.259] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:101:0) after 1m0s
[06:17:15.334] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:101:0)
[06:17:15.334] Timer tick, asking Buildbucket for the build status
[06:17:15.614] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:15.614] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:102:0) after 1m0s
[06:18:15.635] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:102:0)
[06:18:15.635] Timer tick, asking Buildbucket for the build status
[06:18:15.743] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:15.743] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:103:0) after 1m0s
[06:19:15.803] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:103:0)
[06:19:15.803] Timer tick, asking Buildbucket for the build status
[06:19:15.881] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:15.882] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:104:0) after 1m0s
[06:20:15.926] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:104:0)
[06:20:15.926] Timer tick, asking Buildbucket for the build status
[06:20:16.010] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:16.010] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:105:0) after 1m0s
[06:21:16.091] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:105:0)
[06:21:16.091] Timer tick, asking Buildbucket for the build status
[06:21:16.359] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:16.359] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:106:0) after 1m0s
[06:22:16.384] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:106:0)
[06:22:16.384] Timer tick, asking Buildbucket for the build status
[06:22:16.731] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:16.731] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:107:0) after 1m0s
[06:23:16.719] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:107:0)
[06:23:16.719] Timer tick, asking Buildbucket for the build status
[06:23:16.911] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:16.911] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:108:0) after 1m0s
[06:24:16.894] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:108:0)
[06:24:16.894] Timer tick, asking Buildbucket for the build status
[06:24:17.024] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:17.024] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:109:0) after 1m0s
[06:25:17.045] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:109:0)
[06:25:17.045] Timer tick, asking Buildbucket for the build status
[06:25:17.134] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:17.134] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:110:0) after 1m0s
[06:26:17.173] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:110:0)
[06:26:17.173] Timer tick, asking Buildbucket for the build status
[06:26:17.246] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:17.247] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:111:0) after 1m0s
[06:27:17.266] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:111:0)
[06:27:17.266] Timer tick, asking Buildbucket for the build status
[06:27:17.453] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:17.453] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:112:0) after 1m0s
[06:28:17.464] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:112:0)
[06:28:17.464] Timer tick, asking Buildbucket for the build status
[06:28:17.787] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:17.787] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:113:0) after 1m0s
[06:29:17.832] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:113:0)
[06:29:17.832] Timer tick, asking Buildbucket for the build status
[06:29:17.912] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:17.912] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:114:0) after 1m0s
[06:30:18.063] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:114:0)
[06:30:18.063] Timer tick, asking Buildbucket for the build status
[06:30:18.181] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:18.181] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:115:0) after 1m0s
[06:31:18.199] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:115:0)
[06:31:18.199] Timer tick, asking Buildbucket for the build status
[06:31:18.274] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:18.274] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:116:0) after 1m0s
[06:32:18.321] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:116:0)
[06:32:18.321] Timer tick, asking Buildbucket for the build status
[06:32:18.401] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:18.401] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:117:0) after 1m0s
[06:33:18.432] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:117:0)
[06:33:18.432] Timer tick, asking Buildbucket for the build status
[06:33:18.516] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:18.516] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:118:0) after 1m0s
[06:34:18.541] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:118:0)
[06:34:18.541] Timer tick, asking Buildbucket for the build status
[06:34:18.618] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:18.618] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:119:0) after 1m0s
[06:35:18.639] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:119:0)
[06:35:18.639] Timer tick, asking Buildbucket for the build status
[06:35:18.886] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:18.886] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:120:0) after 1m0s
[06:36:18.906] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:120:0)
[06:36:18.906] Timer tick, asking Buildbucket for the build status
[06:36:18.995] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:18.995] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:121:0) after 1m0s
[06:37:19.018] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:121:0)
[06:37:19.018] Timer tick, asking Buildbucket for the build status
[06:37:19.403] Build 8854262516619670736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:19.403] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9019692578555885376:122:0) after 1m0s
[06:37:51.876] Received PubSub notification, asking Buildbucket for the build status
[06:37:52.099] Build 8854262516619670736: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[06:37:52.099] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614321471506196",
"created_by": "project:chromium",
"created_ts": "1614314269389472",
"failure_reason": "BUILD_FAILURE",
"id": "8854262516619670736",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bad2a9914bc356c6602361bf21c767ec010e7213\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**bf_cache_content_shell_test_apk on Android device Nexus 5** failed.\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.components.browser_ui.widget.RadioButtonRenderTest#testRadioButtonWithDescriptionLayout__NightModeEnabled\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 150.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"bad2a9914bc356c6602361bf21c767ec010e7213\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-73-4r7b\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.android\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 8017, \"got_angle_revision\": \"77637f2dd222530c721018185a90e24a51e7a745\", \"got_dawn_revision\": \"545a6970cbe9e986dd25e01f7ecf2f9a1b17c756\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"bad2a9914bc356c6602361bf21c767ec010e7213\", \"got_revision_cp\": \"refs/heads/master@{#858025}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"349abccec8f7ebd1259de11965d58790a76b0ba4\", \"got_v8_revision\": \"bd0108b4c88e0d6f2350cb79b5f363fbd02f3eb7\", \"got_v8_revision_cp\": \"refs/heads/9.0.257@{#1}\", \"got_webrtc_revision\": \"bb52bdf09516ca548c4aff50526eda561f239bc0\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33341}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.android:android-bfcache-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bad2a9914bc356c6602361bf21c767ec010e7213\", \"swarm_hashes_refs/heads/master(at){#858025}_without_patch\": {\"android_browsertests\": \"d710fcd7dd28f9594c9218eb5ea611cdf2961ff4\", \"chrome_public_test_apk\": \"5ae5995ed48972d3cf3913dc1ded605ae400728d\", \"content_browsertests\": \"67f5a8b1cd444c543beddfc8e45fb78f6811e1fc\", \"content_shell_test_apk\": \"c80f93383db6312455026ebdf003f2bf457bc6c9\", \"content_unittests\": \"3a4a887b06aa894b9ae4a3b9acefc7c28b33be1e\", \"unit_tests\": \"347c2d3964fe8a5071e9a90834aac45dcadcf581\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_12fe258969bd458c0c491cc8ec8a110de21b19ba6d4540c003334ed929b828ba_v2\", \"builder_1baf36be136c6e37e5283db20727ce1fca753922b4729c01ac3834cd33897d7d_v2\", \"builder_929ff5fc16a6e3805d1df535bec80a7a81511d72ae0698ab5053153c2404cba8_v2\", \"builder_a2d0deb167035deb42f2d46ec8df60bd17682f54960fd7d9f79bcb4fddee3411_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-73-4r7b\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**bf_cache_content_shell_test_apk on Android device Nexus 5** failed.\\n\\n**bf_cache_chrome_public_test_apk on Android device Nexus 5** failed because of:\\n\\n- org.chromium.components.browser_ui.widget.RadioButtonRenderTest#testRadioButtonWithDescriptionLayout__NightModeEnabled\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614314271723715",
"status": "COMPLETED",
"status_changed_ts": "1614314272829735",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/8017",
"builder:android-bfcache-rel",
"buildset:commit/git/bad2a9914bc356c6602361bf21c767ec010e7213",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bad2a9914bc356c6602361bf21c767ec010e7213",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019692578555885376",
"scheduler_job_id:chromium/android-bfcache-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854262516619670736/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:51f5727595de7b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614321471506517",
"url": "https://ci.chromium.org/b/8854262516619670736",
"utcnow_ts": "1614321472080177"
}
}
[06:37:52.099] Invocation finished in 2h0m3.940335642s with status FAILED