[01:36:58.516] New invocation is queued and will start shortly
[01:37:00.423] Starting the invocation (attempt 1)
[01:37:00.480] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:37:00.480] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:37:00.480] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9045977075506780208",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"48236673a1c443f2d5776245c85b2f4b5c4c27ee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9045977075506780208",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"gitiles_ref:refs/heads/master"
]
}
[01:37:01.141] Failed to add buildbucket build - googleapi: got HTTP response code 500 with body: 500 Internal Server Error
The server has either erred or is incapable of performing the requested operation.
[01:37:01.141] The invocation will be retried
[01:37:06.367] Starting the invocation (attempt 2)
[01:37:06.441] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:37:06.441] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:37:06.441] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9045977075506780208",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"48236673a1c443f2d5776245c85b2f4b5c4c27ee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9045977075506780208",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"gitiles_ref:refs/heads/master"
]
}
[01:37:06.737] Failed to add buildbucket build - googleapi: got HTTP response code 500 with body: 500 Internal Server Error
The server has either erred or is incapable of performing the requested operation.
[01:37:06.737] The invocation will be retried
[01:37:16.927] Starting the invocation (attempt 3)
[01:37:17.004] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:37:17.004] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:37:17.004] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9045977075506780208",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"48236673a1c443f2d5776245c85b2f4b5c4c27ee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9045977075506780208",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"gitiles_ref:refs/heads/master"
]
}
[01:37:17.449] Failed to add buildbucket build - googleapi: got HTTP response code 500 with body: 500 Internal Server Error
The server has either erred or is incapable of performing the requested operation.
[01:37:17.449] The invocation will be retried
[01:37:37.736] Starting the invocation (attempt 4)
[01:37:37.776] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:37:37.776] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:37:37.777] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9045977075506780208",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"48236673a1c443f2d5776245c85b2f4b5c4c27ee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9045977075506780208",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"gitiles_ref:refs/heads/master"
]
}
[01:37:38.857] Failed to add buildbucket build - googleapi: got HTTP response code 500 with body: 500 Internal Server Error
The server has either erred or is incapable of performing the requested operation.
[01:37:38.858] The invocation will be retried
[01:38:18.966] Starting the invocation (attempt 5)
[01:38:19.007] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:38:19.007] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:38:19.007] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9045977075506780208",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"48236673a1c443f2d5776245c85b2f4b5c4c27ee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9045977075506780208",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"gitiles_ref:refs/heads/master"
]
}
[01:38:19.358] Failed to add buildbucket build - googleapi: got HTTP response code 500 with body: 500 Internal Server Error
The server has either erred or is incapable of performing the requested operation.
[01:38:19.358] The invocation will be retried
[01:39:39.626] Starting the invocation (attempt 6)
[01:39:39.662] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:39:39.663] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:39:39.663] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9045977075506780208",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"48236673a1c443f2d5776245c85b2f4b5c4c27ee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9045977075506780208",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"gitiles_ref:refs/heads/master"
]
}
[01:39:39.994] Failed to add buildbucket build - googleapi: got HTTP response code 500 with body: 500 Internal Server Error
The server has either erred or is incapable of performing the requested operation.
[01:39:39.994] The invocation will be retried
[01:42:20.074] Starting the invocation (attempt 7)
[01:42:20.115] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:42:20.115] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:42:20.115] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9045977075506780208",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"48236673a1c443f2d5776245c85b2f4b5c4c27ee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9045977075506780208",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"gitiles_ref:refs/heads/master"
]
}
[01:42:20.590] Failed to add buildbucket build - googleapi: got HTTP response code 500 with body: 500 Internal Server Error
The server has either erred or is incapable of performing the requested operation.
[01:42:20.591] The invocation will be retried
[01:47:40.700] Starting the invocation (attempt 8)
[01:47:40.742] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:47:40.742] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:47:40.742] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9045977075506780208",
"parameters_json": "{\"builder_name\":\"android-bfcache-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"48236673a1c443f2d5776245c85b2f4b5c4c27ee\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:android-bfcache-rel",
"scheduler_invocation_id:9045977075506780208",
"scheduler_job_id:chromium/android-bfcache-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"gitiles_ref:refs/heads/master"
]
}
[01:47:42.307] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1589248060931512",
"id": "8880546341219374176",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"48236673a1c443f2d5776245c85b2f4b5c4c27ee\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1589248061951381",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/2647",
"builder:android-bfcache-rel",
"buildset:commit/git/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045977075506780208",
"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/8880546341219374176/+/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": "1589248061951562",
"url": "https://ci.chromium.org/b/8880546341219374176",
"utcnow_ts": "1589248062288197"
}
}
[01:47:42.307] Task URL: https://ci.chromium.org/b/8880546341219374176
[01:47:42.307] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:23:0) after 1m0s
[01:48:42.399] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:23:0)
[01:48:42.399] Timer tick, asking Buildbucket for the build status
[01:48:42.618] Build 8880546341219374176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:48:42.618] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:24:0) after 1m0s
[01:49:42.651] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:24:0)
[01:49:42.651] Timer tick, asking Buildbucket for the build status
[01:49:43.063] Build 8880546341219374176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:49:43.063] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:25:0) after 1m0s
[01:49:56.775] Received PubSub notification, asking Buildbucket for the build status
[01:49:57.163] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:43.227] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:25:0)
[01:50:43.227] Timer tick, asking Buildbucket for the build status
[01:50:43.399] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:43.399] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:27:0) after 1m0s
[01:51:43.423] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:27:0)
[01:51:43.423] Timer tick, asking Buildbucket for the build status
[01:51:43.791] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:43.791] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:28:0) after 1m0s
[01:52:43.866] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:28:0)
[01:52:43.866] Timer tick, asking Buildbucket for the build status
[01:52:44.222] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:44.222] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:29:0) after 1m0s
[01:53:44.255] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:29:0)
[01:53:44.255] Timer tick, asking Buildbucket for the build status
[01:53:44.417] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:44.417] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:30:0) after 1m0s
[01:54:44.457] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:30:0)
[01:54:44.457] Timer tick, asking Buildbucket for the build status
[01:54:44.585] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:44.585] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:31:0) after 1m0s
[01:55:44.658] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:31:0)
[01:55:44.658] Timer tick, asking Buildbucket for the build status
[01:55:45.313] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:45.313] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:32:0) after 1m0s
[01:56:45.353] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:32:0)
[01:56:45.353] Timer tick, asking Buildbucket for the build status
[01:56:45.477] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:45.477] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:33:0) after 1m0s
[01:57:45.503] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:33:0)
[01:57:45.503] Timer tick, asking Buildbucket for the build status
[01:57:45.711] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:45.711] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:34:0) after 1m0s
[01:58:45.904] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:34:0)
[01:58:45.904] Timer tick, asking Buildbucket for the build status
[01:58:46.614] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:46.614] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:35:0) after 1m0s
[01:59:46.668] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:35:0)
[01:59:46.668] Timer tick, asking Buildbucket for the build status
[01:59:46.875] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:46.875] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:36:0) after 1m0s
[02:00:46.966] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:36:0)
[02:00:46.966] Timer tick, asking Buildbucket for the build status
[02:00:47.551] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:47.551] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:37:0) after 1m0s
[02:01:47.601] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:37:0)
[02:01:47.601] Timer tick, asking Buildbucket for the build status
[02:01:48.023] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:48.023] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:38:0) after 1m0s
[02:02:48.273] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:38:0)
[02:02:48.273] Timer tick, asking Buildbucket for the build status
[02:02:48.465] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:48.465] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:39:0) after 1m0s
[02:03:48.659] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:39:0)
[02:03:48.659] Timer tick, asking Buildbucket for the build status
[02:03:50.250] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:50.250] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:40:0) after 1m0s
[02:04:50.525] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:40:0)
[02:04:50.525] Timer tick, asking Buildbucket for the build status
[02:04:50.894] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:50.894] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:41:0) after 1m0s
[02:05:50.907] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:41:0)
[02:05:50.907] Timer tick, asking Buildbucket for the build status
[02:05:51.197] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:51.197] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:42:0) after 1m0s
[02:06:51.874] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:42:0)
[02:06:51.874] Timer tick, asking Buildbucket for the build status
[02:06:52.336] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:52.336] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:43:0) after 1m0s
[02:07:52.475] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:43:0)
[02:07:52.475] Timer tick, asking Buildbucket for the build status
[02:07:52.909] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:52.909] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:44:0) after 1m0s
[02:08:53.048] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:44:0)
[02:08:53.048] Timer tick, asking Buildbucket for the build status
[02:08:53.759] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:53.759] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:45:0) after 1m0s
[02:09:53.852] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:45:0)
[02:09:53.852] Timer tick, asking Buildbucket for the build status
[02:09:54.103] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:54.103] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:46:0) after 1m0s
[02:10:54.313] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:46:0)
[02:10:54.313] Timer tick, asking Buildbucket for the build status
[02:10:54.526] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:54.526] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:47:0) after 1m0s
[02:11:54.580] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:47:0)
[02:11:54.580] Timer tick, asking Buildbucket for the build status
[02:11:54.853] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:54.853] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:48:0) after 1m0s
[02:12:54.902] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:48:0)
[02:12:54.902] Timer tick, asking Buildbucket for the build status
[02:12:55.290] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:55.290] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:49:0) after 1m0s
[02:13:55.314] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:49:0)
[02:13:55.314] Timer tick, asking Buildbucket for the build status
[02:13:55.480] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:55.480] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:50:0) after 1m0s
[02:14:55.764] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:50:0)
[02:14:55.764] Timer tick, asking Buildbucket for the build status
[02:14:55.971] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:56.041] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:51:0) after 1m0s
[02:15:56.083] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:51:0)
[02:15:56.083] Timer tick, asking Buildbucket for the build status
[02:15:56.232] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:56.232] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:52:0) after 1m0s
[02:16:56.484] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:52:0)
[02:16:56.484] Timer tick, asking Buildbucket for the build status
[02:16:56.600] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:56.600] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:53:0) after 1m0s
[02:17:56.752] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:53:0)
[02:17:56.752] Timer tick, asking Buildbucket for the build status
[02:17:56.994] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:56.994] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:54:0) after 1m0s
[02:18:57.472] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:54:0)
[02:18:57.472] Timer tick, asking Buildbucket for the build status
[02:18:57.692] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:57.692] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:55:0) after 1m0s
[02:19:57.929] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:55:0)
[02:19:57.930] Timer tick, asking Buildbucket for the build status
[02:19:58.750] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:58.750] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:56:0) after 1m0s
[02:20:58.919] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:56:0)
[02:20:58.919] Timer tick, asking Buildbucket for the build status
[02:20:59.105] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:59.105] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:57:0) after 1m0s
[02:21:59.214] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:57:0)
[02:21:59.214] Timer tick, asking Buildbucket for the build status
[02:21:59.603] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:59.603] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:58:0) after 1m0s
[02:22:59.793] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:58:0)
[02:22:59.793] Timer tick, asking Buildbucket for the build status
[02:23:00.557] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:00.557] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:59:0) after 1m0s
[02:24:01.486] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:59:0)
[02:24:01.486] Timer tick, asking Buildbucket for the build status
[02:24:01.703] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:01.703] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:60:0) after 1m0s
[02:25:01.826] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:60:0)
[02:25:01.826] Timer tick, asking Buildbucket for the build status
[02:25:02.684] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:02.685] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:61:0) after 1m0s
[02:26:02.860] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:61:0)
[02:26:02.860] Timer tick, asking Buildbucket for the build status
[02:26:03.286] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:03.286] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:62:0) after 1m0s
[02:27:03.642] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:62:0)
[02:27:03.642] Timer tick, asking Buildbucket for the build status
[02:27:03.854] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:03.854] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:63:0) after 1m0s
[02:28:04.042] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:63:0)
[02:28:04.042] Timer tick, asking Buildbucket for the build status
[02:28:04.291] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:04.291] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:64:0) after 1m0s
[02:29:04.460] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:64:0)
[02:29:04.460] Timer tick, asking Buildbucket for the build status
[02:29:04.690] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:04.690] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:65:0) after 1m0s
[02:30:04.728] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:65:0)
[02:30:04.728] Timer tick, asking Buildbucket for the build status
[02:30:05.076] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:05.076] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:66:0) after 1m0s
[02:31:05.435] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:66:0)
[02:31:05.435] Timer tick, asking Buildbucket for the build status
[02:31:05.734] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:05.734] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:67:0) after 1m0s
[02:32:05.789] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:67:0)
[02:32:05.789] Timer tick, asking Buildbucket for the build status
[02:32:05.924] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:05.924] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:68:0) after 1m0s
[02:33:05.998] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:68:0)
[02:33:05.998] Timer tick, asking Buildbucket for the build status
[02:33:06.173] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:06.173] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:69:0) after 1m0s
[02:34:06.243] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:69:0)
[02:34:06.243] Timer tick, asking Buildbucket for the build status
[02:34:06.365] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:06.365] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:70:0) after 1m0s
[02:35:06.420] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:70:0)
[02:35:06.420] Timer tick, asking Buildbucket for the build status
[02:35:06.591] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:06.591] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:71:0) after 1m0s
[02:36:06.668] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:71:0)
[02:36:06.668] Timer tick, asking Buildbucket for the build status
[02:36:06.780] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:06.780] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:72:0) after 1m0s
[02:37:06.976] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:72:0)
[02:37:06.976] Timer tick, asking Buildbucket for the build status
[02:37:07.162] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:07.162] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:73:0) after 1m0s
[02:38:07.222] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:73:0)
[02:38:07.222] Timer tick, asking Buildbucket for the build status
[02:38:07.405] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:07.405] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:74:0) after 1m0s
[02:39:07.498] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:74:0)
[02:39:07.498] Timer tick, asking Buildbucket for the build status
[02:39:07.695] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:07.695] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:75:0) after 1m0s
[02:40:07.757] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:75:0)
[02:40:07.757] Timer tick, asking Buildbucket for the build status
[02:40:08.722] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:08.723] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:76:0) after 1m0s
[02:41:08.832] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:76:0)
[02:41:08.832] Timer tick, asking Buildbucket for the build status
[02:41:09.226] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:09.226] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:77:0) after 1m0s
[02:42:09.257] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:77:0)
[02:42:09.257] Timer tick, asking Buildbucket for the build status
[02:42:09.490] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:09.490] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:78:0) after 1m0s
[02:43:09.548] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:78:0)
[02:43:09.548] Timer tick, asking Buildbucket for the build status
[02:43:09.674] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:09.674] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:79:0) after 1m0s
[02:44:09.793] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:79:0)
[02:44:09.793] Timer tick, asking Buildbucket for the build status
[02:44:10.203] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:10.203] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:80:0) after 1m0s
[02:45:10.276] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:80:0)
[02:45:10.276] Timer tick, asking Buildbucket for the build status
[02:45:10.471] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:10.471] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:81:0) after 1m0s
[02:46:10.567] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:81:0)
[02:46:10.567] Timer tick, asking Buildbucket for the build status
[02:46:10.744] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:10.744] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:82:0) after 1m0s
[02:47:10.836] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:82:0)
[02:47:10.836] Timer tick, asking Buildbucket for the build status
[02:47:12.337] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:12.337] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:83:0) after 1m0s
[02:48:41.524] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:83:0)
[02:48:41.524] Timer tick, asking Buildbucket for the build status
[02:48:41.745] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:41.745] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:84:0) after 1m0s
[02:49:41.941] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:84:0)
[02:49:41.941] Timer tick, asking Buildbucket for the build status
[02:49:42.200] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:42.200] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:85:0) after 1m0s
[02:50:42.335] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:85:0)
[02:50:42.335] Timer tick, asking Buildbucket for the build status
[02:50:44.117] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:44.117] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:86:0) after 1m0s
[02:51:44.489] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:86:0)
[02:51:44.489] Timer tick, asking Buildbucket for the build status
[02:51:44.753] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:44.753] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:87:0) after 1m0s
[02:52:45.238] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:87:0)
[02:52:45.238] Timer tick, asking Buildbucket for the build status
[02:52:46.191] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:46.191] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:88:0) after 1m0s
[02:53:46.187] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:88:0)
[02:53:46.188] Timer tick, asking Buildbucket for the build status
[02:53:46.322] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:46.323] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:89:0) after 1m0s
[02:54:46.396] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:89:0)
[02:54:46.396] Timer tick, asking Buildbucket for the build status
[02:54:46.607] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:46.607] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:90:0) after 1m0s
[02:55:46.851] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:90:0)
[02:55:46.851] Timer tick, asking Buildbucket for the build status
[02:55:47.530] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:47.530] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:91:0) after 1m0s
[02:56:47.717] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:91:0)
[02:56:47.717] Timer tick, asking Buildbucket for the build status
[02:56:48.046] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:48.046] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:92:0) after 1m0s
[02:57:48.223] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:92:0)
[02:57:48.223] Timer tick, asking Buildbucket for the build status
[02:57:49.188] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:49.188] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:93:0) after 1m0s
[02:58:49.179] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:93:0)
[02:58:49.179] Timer tick, asking Buildbucket for the build status
[02:58:49.510] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:49.510] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:94:0) after 1m0s
[02:59:49.570] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:94:0)
[02:59:49.571] Timer tick, asking Buildbucket for the build status
[02:59:49.992] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:49.992] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:95:0) after 1m0s
[03:00:50.126] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:95:0)
[03:00:50.126] Timer tick, asking Buildbucket for the build status
[03:00:50.468] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:50.468] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:96:0) after 1m0s
[03:01:50.644] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:96:0)
[03:01:50.644] Timer tick, asking Buildbucket for the build status
[03:01:50.813] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:50.813] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:97:0) after 1m0s
[03:02:50.951] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:97:0)
[03:02:50.951] Timer tick, asking Buildbucket for the build status
[03:02:53.765] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:53.765] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:98:0) after 1m0s
[03:03:54.504] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:98:0)
[03:03:54.504] Timer tick, asking Buildbucket for the build status
[03:03:54.847] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:54.847] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:99:0) after 1m0s
[03:04:54.878] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:99:0)
[03:04:54.878] Timer tick, asking Buildbucket for the build status
[03:04:55.062] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:55.062] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:100:0) after 1m0s
[03:05:55.229] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:100:0)
[03:05:55.229] Timer tick, asking Buildbucket for the build status
[03:05:55.439] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:55.439] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:101:0) after 1m0s
[03:06:56.201] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:101:0)
[03:06:56.201] Timer tick, asking Buildbucket for the build status
[03:06:56.435] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:56.435] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:102:0) after 1m0s
[03:07:56.607] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:102:0)
[03:07:56.607] Timer tick, asking Buildbucket for the build status
[03:07:56.978] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:56.978] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:103:0) after 1m0s
[03:08:57.399] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:103:0)
[03:08:57.399] Timer tick, asking Buildbucket for the build status
[03:08:57.588] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:57.588] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:104:0) after 1m0s
[03:09:57.759] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:104:0)
[03:09:57.759] Timer tick, asking Buildbucket for the build status
[03:09:58.248] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:58.249] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:105:0) after 1m0s
[03:10:58.335] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:105:0)
[03:10:58.335] Timer tick, asking Buildbucket for the build status
[03:10:58.939] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:58.939] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:106:0) after 1m0s
[03:11:58.969] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:106:0)
[03:11:58.969] Timer tick, asking Buildbucket for the build status
[03:11:59.162] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:59.162] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:107:0) after 1m0s
[03:12:59.228] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:107:0)
[03:12:59.228] Timer tick, asking Buildbucket for the build status
[03:13:01.086] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:01.086] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:108:0) after 1m0s
[03:14:02.009] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:108:0)
[03:14:02.009] Timer tick, asking Buildbucket for the build status
[03:14:02.196] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:02.196] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:109:0) after 1m0s
[03:15:02.283] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:109:0)
[03:15:02.283] Timer tick, asking Buildbucket for the build status
[03:15:03.455] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:03.455] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:110:0) after 1m0s
[03:16:03.525] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:110:0)
[03:16:03.525] Timer tick, asking Buildbucket for the build status
[03:16:03.753] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:03.753] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:111:0) after 1m0s
[03:17:03.760] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:111:0)
[03:17:03.760] Timer tick, asking Buildbucket for the build status
[03:17:04.026] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:04.026] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:112:0) after 1m0s
[03:18:04.081] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:112:0)
[03:18:04.081] Timer tick, asking Buildbucket for the build status
[03:18:04.518] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:04.518] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:113:0) after 1m0s
[03:19:04.585] Handling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:113:0)
[03:19:04.585] Timer tick, asking Buildbucket for the build status
[03:19:04.758] Build 8880546341219374176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:04.758] Scheduling timer "check-buildbucket-build-status" (chromium/android-bfcache-rel:9045977075506780208:114:0) after 1m0s
[03:19:25.746] Received PubSub notification, asking Buildbucket for the build status
[03:19:25.845] Build 8880546341219374176: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[03:19:25.845] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1589253565290032",
"created_by": "project:chromium",
"created_ts": "1589248060931512",
"failure_reason": "BUILD_FAILURE",
"id": "8880546341219374176",
"parameters_json": "{\"builder_name\": \"android-bfcache-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"48236673a1c443f2d5776245c85b2f4b5c4c27ee\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"3 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- RenderDocumentHostUserDataTest.CrossSiteNavigation\\n\\n- SitePerProcessBrowserTest.NavigateMainFrameToChildSite\\n\\n- RenderDocumentHostUserDataTest.FailedNavigation\\n\\n- All/RenderFrameHostManagerDefaultProcessTest.NavigationRacesWithSitelessCommitInDefaultProcess/1\\n\\n- ...20 more failure(s) (24 total)...\\n\\n**bf_cache_content_unittests on Android device Nexus 5** failed because of:\\n\\n- NavigatorTest.RendererNonUserInitiatedNavigationCancelSimilarNavigation\\n\\n- NavigatorTest.SimpleRendererInitiatedCrossSiteNavigation\\n\\n- NavigatorTest.RendererNonUserInitiatedNavigationCancelsRendererUserInitiated\\n\\n- NavigatorTest.RendererUserInitiatedNavigationCancel\\n\\n- ...1 more failure(s) (5 total)...\\n\\n#### ...1 more test(s)...\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-37-k1y6\", \"branch\": \"refs/heads/master\", \"buildername\": \"android-bfcache-rel\", \"buildnumber\": 2647, \"got_angle_revision\": \"d654234e6e38a5b6e6f78ac216fc7aae62395c50\", \"got_dawn_revision\": \"02beecaec5cdfa809f1dbea883a60bb040629590\", \"got_nacl_revision\": \"98e6f0f2dc32172835122736bbc317335d8d20e4\", \"got_revision\": \"48236673a1c443f2d5776245c85b2f4b5c4c27ee\", \"got_revision_cp\": \"refs/heads/master@{#767617}\", \"got_swarming_client_revision\": \"160b445a44e0daacf6f3f8570ca2707ec451f374\", \"got_swiftshader_revision\": \"d9ba4b7dd30b2a5d824d7230d176c0ff99c2e5a2\", \"got_v8_revision\": \"f03a13f2c864d2acbd875036bad21475c478d7c7\", \"got_v8_revision_cp\": \"refs/heads/8.4.342@{#1}\", \"got_webrtc_revision\": \"6efc14b33db0173c2710101aad27b574df9601ce\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31211}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.android.fyi\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"48236673a1c443f2d5776245c85b2f4b5c4c27ee\", \"swarm_hashes\": {\"android_browsertests\": \"ab4e1762b7581a7b6f1628c25fe997988912b38b\", \"chrome_public_test_apk\": \"574bfef71da7d1753df6ec393e2240cf323de048\", \"content_browsertests\": \"e4d6a6cf322e7f0ab23d0b4219f8ef0df3d3fc58\", \"content_shell_test_apk\": \"35a5963d59680268462ab902fabbbe5f645f907f\", \"content_unittests\": \"b8ba2933f0e73e1cf61c45a3c87ec08b83b118f2\", \"unit_tests\": \"6186737a0a1e31592b919c51958c5a04876069f0\"}, \"swarm_hashes_refs/heads/master(at){#767617}_without_patch\": {\"android_browsertests\": \"ab4e1762b7581a7b6f1628c25fe997988912b38b\", \"chrome_public_test_apk\": \"574bfef71da7d1753df6ec393e2240cf323de048\", \"content_browsertests\": \"e4d6a6cf322e7f0ab23d0b4219f8ef0df3d3fc58\", \"content_shell_test_apk\": \"35a5963d59680268462ab902fabbbe5f645f907f\", \"content_unittests\": \"b8ba2933f0e73e1cf61c45a3c87ec08b83b118f2\", \"unit_tests\": \"6186737a0a1e31592b919c51958c5a04876069f0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_06f7322a2412f6d5847bf0db96514be9a9e250df6423d332852846c662c6ba34_v2\", \"builder_0b7b4a76c348e02b1b0360cbf12cf6c81ca8949f924020091b0ce0558154e869_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_3e75b41c9bcf12a22209c03b338cce1fafa12941d3074ed1e1ed2450e6b71594_v2\", \"builder_86caf262f74ae694bec00fbb86541daa2df96eb35c1a4d9a06c3c1dcd129237e_v2\", \"builder_9b8e7cf0a756f5448fe63e5ba03689dec6fdccd23b3dfddd2910706476b68383_v2\", \"builder_abe2adbd32ad911c3e8d1f384e915329cf1f65e427edb6b91a9fbb61a55ed743_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-37-k1y6\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5061-3bd2529\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"3 Test Suite(s) failed.\\n\\n**bf_cache_content_browsertests on Android device Nexus 5** failed because of:\\n\\n- RenderDocumentHostUserDataTest.CrossSiteNavigation\\n\\n- SitePerProcessBrowserTest.NavigateMainFrameToChildSite\\n\\n- RenderDocumentHostUserDataTest.FailedNavigation\\n\\n- All/RenderFrameHostManagerDefaultProcessTest.NavigationRacesWithSitelessCommitInDefaultProcess/1\\n\\n- ...20 more failure(s) (24 total)...\\n\\n**bf_cache_content_unittests on Android device Nexus 5** failed because of:\\n\\n- NavigatorTest.RendererNonUserInitiatedNavigationCancelSimilarNavigation\\n\\n- NavigatorTest.SimpleRendererInitiatedCrossSiteNavigation\\n\\n- NavigatorTest.RendererNonUserInitiatedNavigationCancelsRendererUserInitiated\\n\\n- NavigatorTest.RendererUserInitiatedNavigationCancel\\n\\n- ...1 more failure(s) (5 total)...\\n\\n#### ...1 more test(s)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1589248195773176",
"status": "COMPLETED",
"status_changed_ts": "1589248196247010",
"tags": [
"build_address:luci.chromium.ci/android-bfcache-rel/2647",
"builder:android-bfcache-rel",
"buildset:commit/git/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/48236673a1c443f2d5776245c85b2f4b5c4c27ee",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045977075506780208",
"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/8880546341219374176/+/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:4c1f627cccac9b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1589253565457358",
"url": "https://ci.chromium.org/b/8880546341219374176",
"utcnow_ts": "1589253565830518"
}
}
[03:19:25.845] Invocation finished in 1h42m27.34788113s with status FAILED