[06:58:48.907] New invocation is queued and will start shortly
[06:58:50.045] Starting the invocation (attempt 1)
[06:58:50.087] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:58:50.089] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:58:50.089] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030917730670538400",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"59d6e097cda651bb22888aeda1274309534abb68\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9030917730670538400",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/59d6e097cda651bb22888aeda1274309534abb68",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/59d6e097cda651bb22888aeda1274309534abb68",
"gitiles_ref:refs/heads/master"
]
}
[06:58:50.933] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1603609130184065",
"id": "8865487668666527504",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"59d6e097cda651bb22888aeda1274309534abb68\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603609130810069",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/18760",
"builder:Linux CFI",
"buildset:commit/git/59d6e097cda651bb22888aeda1274309534abb68",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/59d6e097cda651bb22888aeda1274309534abb68",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030917730670538400",
"scheduler_job_id:chromium/Linux CFI",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865487668666527504/+/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": "1603609130810177",
"url": "https://ci.chromium.org/b/8865487668666527504",
"utcnow_ts": "1603609130925120"
}
}
[06:58:50.933] Task URL: https://ci.chromium.org/b/8865487668666527504
[06:58:50.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:2:0) after 1m0s
[06:59:50.801] Received PubSub notification, asking Buildbucket for the build status
[06:59:50.891] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:50.966] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:2:0)
[06:59:50.966] Timer tick, asking Buildbucket for the build status
[06:59:51.117] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:51.117] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:4:0) after 1m0s
[07:00:51.256] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:4:0)
[07:00:51.256] Timer tick, asking Buildbucket for the build status
[07:00:51.360] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:51.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:5:0) after 1m0s
[07:01:51.392] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:5:0)
[07:01:51.392] Timer tick, asking Buildbucket for the build status
[07:01:51.997] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:51.997] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:6:0) after 1m0s
[07:02:52.116] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:6:0)
[07:02:52.116] Timer tick, asking Buildbucket for the build status
[07:02:52.196] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:52.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:7:0) after 1m0s
[07:03:52.294] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:7:0)
[07:03:52.294] Timer tick, asking Buildbucket for the build status
[07:03:52.425] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:52.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:8:0) after 1m0s
[07:04:52.447] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:8:0)
[07:04:52.447] Timer tick, asking Buildbucket for the build status
[07:04:52.545] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:52.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:9:0) after 1m0s
[07:05:52.568] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:9:0)
[07:05:52.568] Timer tick, asking Buildbucket for the build status
[07:05:52.808] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:52.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:10:0) after 1m0s
[07:06:52.877] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:10:0)
[07:06:52.878] Timer tick, asking Buildbucket for the build status
[07:06:52.942] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:52.942] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:11:0) after 1m0s
[07:07:52.973] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:11:0)
[07:07:52.973] Timer tick, asking Buildbucket for the build status
[07:07:53.198] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:53.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:12:0) after 1m0s
[07:08:53.228] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:12:0)
[07:08:53.228] Timer tick, asking Buildbucket for the build status
[07:08:53.343] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:53.343] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:13:0) after 1m0s
[07:09:53.391] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:13:0)
[07:09:53.391] Timer tick, asking Buildbucket for the build status
[07:09:53.590] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:53.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:14:0) after 1m0s
[07:10:53.678] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:14:0)
[07:10:53.678] Timer tick, asking Buildbucket for the build status
[07:10:53.746] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:53.746] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:15:0) after 1m0s
[07:11:53.790] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:15:0)
[07:11:53.790] Timer tick, asking Buildbucket for the build status
[07:11:53.864] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:53.864] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:16:0) after 1m0s
[07:12:53.954] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:16:0)
[07:12:53.954] Timer tick, asking Buildbucket for the build status
[07:12:54.029] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:54.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:17:0) after 1m0s
[07:13:54.102] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:17:0)
[07:13:54.102] Timer tick, asking Buildbucket for the build status
[07:13:54.186] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:54.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:18:0) after 1m0s
[07:14:54.247] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:18:0)
[07:14:54.247] Timer tick, asking Buildbucket for the build status
[07:14:54.522] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:54.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:19:0) after 1m0s
[07:15:54.548] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:19:0)
[07:15:54.548] Timer tick, asking Buildbucket for the build status
[07:15:54.612] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:54.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:20:0) after 1m0s
[07:16:54.684] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:20:0)
[07:16:54.684] Timer tick, asking Buildbucket for the build status
[07:16:54.742] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:54.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:21:0) after 1m0s
[07:17:54.905] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:21:0)
[07:17:54.905] Timer tick, asking Buildbucket for the build status
[07:17:55.000] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:55.000] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:22:0) after 1m0s
[07:18:55.033] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:22:0)
[07:18:55.033] Timer tick, asking Buildbucket for the build status
[07:18:55.163] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:55.163] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:23:0) after 1m0s
[07:19:55.207] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:23:0)
[07:19:55.207] Timer tick, asking Buildbucket for the build status
[07:19:55.339] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:55.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:24:0) after 1m0s
[07:20:55.372] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:24:0)
[07:20:55.372] Timer tick, asking Buildbucket for the build status
[07:20:55.547] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:55.547] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:25:0) after 1m0s
[07:21:55.622] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:25:0)
[07:21:55.622] Timer tick, asking Buildbucket for the build status
[07:21:55.705] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:55.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:26:0) after 1m0s
[07:22:55.878] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:26:0)
[07:22:55.878] Timer tick, asking Buildbucket for the build status
[07:22:55.938] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:55.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:27:0) after 1m0s
[07:23:56.007] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:27:0)
[07:23:56.007] Timer tick, asking Buildbucket for the build status
[07:23:56.107] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:56.107] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:28:0) after 1m0s
[07:24:56.137] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:28:0)
[07:24:56.137] Timer tick, asking Buildbucket for the build status
[07:24:56.209] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:56.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:29:0) after 1m0s
[07:25:56.232] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:29:0)
[07:25:56.232] Timer tick, asking Buildbucket for the build status
[07:25:56.483] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:56.483] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:30:0) after 1m0s
[07:26:56.523] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:30:0)
[07:26:56.523] Timer tick, asking Buildbucket for the build status
[07:26:56.593] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:56.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:31:0) after 1m0s
[07:27:56.613] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:31:0)
[07:27:56.613] Timer tick, asking Buildbucket for the build status
[07:27:56.884] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:56.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:32:0) after 1m0s
[07:28:56.966] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:32:0)
[07:28:56.966] Timer tick, asking Buildbucket for the build status
[07:28:57.097] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:57.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:33:0) after 1m0s
[07:29:57.167] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:33:0)
[07:29:57.167] Timer tick, asking Buildbucket for the build status
[07:29:57.381] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:57.381] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:34:0) after 1m0s
[07:30:57.402] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:34:0)
[07:30:57.402] Timer tick, asking Buildbucket for the build status
[07:30:57.472] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:57.472] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:35:0) after 1m0s
[07:31:57.496] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:35:0)
[07:31:57.496] Timer tick, asking Buildbucket for the build status
[07:31:57.568] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:57.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:36:0) after 1m0s
[07:32:57.590] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:36:0)
[07:32:57.590] Timer tick, asking Buildbucket for the build status
[07:32:57.656] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:57.656] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:37:0) after 1m0s
[07:33:57.722] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:37:0)
[07:33:57.722] Timer tick, asking Buildbucket for the build status
[07:33:57.858] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:57.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:38:0) after 1m0s
[07:34:58.018] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:38:0)
[07:34:58.018] Timer tick, asking Buildbucket for the build status
[07:34:58.100] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:58.101] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:39:0) after 1m0s
[07:35:58.172] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:39:0)
[07:35:58.172] Timer tick, asking Buildbucket for the build status
[07:35:58.301] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:58.301] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:40:0) after 1m0s
[07:36:58.419] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:40:0)
[07:36:58.419] Timer tick, asking Buildbucket for the build status
[07:36:58.479] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:58.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:41:0) after 1m0s
[07:37:58.555] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:41:0)
[07:37:58.555] Timer tick, asking Buildbucket for the build status
[07:37:58.624] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:58.624] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:42:0) after 1m0s
[07:38:58.646] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:42:0)
[07:38:58.646] Timer tick, asking Buildbucket for the build status
[07:38:58.746] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:58.746] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:43:0) after 1m0s
[07:39:58.790] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:43:0)
[07:39:58.790] Timer tick, asking Buildbucket for the build status
[07:39:58.852] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:58.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:44:0) after 1m0s
[07:40:58.824] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:44:0)
[07:40:58.824] Timer tick, asking Buildbucket for the build status
[07:40:58.911] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:58.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:45:0) after 1m0s
[07:41:58.938] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:45:0)
[07:41:58.938] Timer tick, asking Buildbucket for the build status
[07:41:59.006] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:59.006] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:46:0) after 1m0s
[07:42:59.037] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:46:0)
[07:42:59.037] Timer tick, asking Buildbucket for the build status
[07:42:59.112] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:59.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:47:0) after 1m0s
[07:43:59.135] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:47:0)
[07:43:59.135] Timer tick, asking Buildbucket for the build status
[07:43:59.304] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:59.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:48:0) after 1m0s
[07:44:59.325] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:48:0)
[07:44:59.325] Timer tick, asking Buildbucket for the build status
[07:44:59.608] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:59.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:49:0) after 1m0s
[07:45:59.661] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:49:0)
[07:45:59.661] Timer tick, asking Buildbucket for the build status
[07:45:59.899] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:59.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:50:0) after 1m0s
[07:46:59.968] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:50:0)
[07:46:59.968] Timer tick, asking Buildbucket for the build status
[07:47:00.162] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:00.162] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:51:0) after 1m0s
[07:48:00.186] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:51:0)
[07:48:00.186] Timer tick, asking Buildbucket for the build status
[07:48:00.429] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:00.429] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:52:0) after 1m0s
[07:49:00.508] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:52:0)
[07:49:00.508] Timer tick, asking Buildbucket for the build status
[07:49:00.620] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:00.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:53:0) after 1m0s
[07:50:00.653] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:53:0)
[07:50:00.653] Timer tick, asking Buildbucket for the build status
[07:50:00.888] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:00.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:54:0) after 1m0s
[07:51:00.910] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:54:0)
[07:51:00.910] Timer tick, asking Buildbucket for the build status
[07:51:01.198] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:01.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:55:0) after 1m0s
[07:52:01.278] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:55:0)
[07:52:01.278] Timer tick, asking Buildbucket for the build status
[07:52:01.349] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:01.349] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:56:0) after 1m0s
[07:53:01.372] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:56:0)
[07:53:01.372] Timer tick, asking Buildbucket for the build status
[07:53:01.548] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:01.548] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:57:0) after 1m0s
[07:54:01.538] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:57:0)
[07:54:01.538] Timer tick, asking Buildbucket for the build status
[07:54:01.682] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:01.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:58:0) after 1m0s
[07:55:01.754] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:58:0)
[07:55:01.754] Timer tick, asking Buildbucket for the build status
[07:55:01.822] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:01.822] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:59:0) after 1m0s
[07:56:01.847] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:59:0)
[07:56:01.847] Timer tick, asking Buildbucket for the build status
[07:56:01.922] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:01.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:60:0) after 1m0s
[07:57:01.978] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:60:0)
[07:57:01.978] Timer tick, asking Buildbucket for the build status
[07:57:02.308] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:02.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:61:0) after 1m0s
[07:58:02.360] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:61:0)
[07:58:02.360] Timer tick, asking Buildbucket for the build status
[07:58:02.533] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:02.533] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:62:0) after 1m0s
[07:59:02.645] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:62:0)
[07:59:02.645] Timer tick, asking Buildbucket for the build status
[07:59:03.003] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:03.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:63:0) after 1m0s
[08:00:03.109] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:63:0)
[08:00:03.109] Timer tick, asking Buildbucket for the build status
[08:00:03.280] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:03.280] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:64:0) after 1m0s
[08:01:03.254] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:64:0)
[08:01:03.254] Timer tick, asking Buildbucket for the build status
[08:01:03.507] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:03.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:65:0) after 1m0s
[08:02:03.502] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:65:0)
[08:02:03.502] Timer tick, asking Buildbucket for the build status
[08:02:03.567] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:03.567] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:66:0) after 1m0s
[08:03:03.626] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:66:0)
[08:03:03.626] Timer tick, asking Buildbucket for the build status
[08:03:03.702] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:03.702] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:67:0) after 1m0s
[08:04:03.743] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:67:0)
[08:04:03.743] Timer tick, asking Buildbucket for the build status
[08:04:04.964] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:04.964] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:68:0) after 1m0s
[08:05:05.054] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:68:0)
[08:05:05.054] Timer tick, asking Buildbucket for the build status
[08:05:05.308] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:05.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:69:0) after 1m0s
[08:06:05.292] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:69:0)
[08:06:05.292] Timer tick, asking Buildbucket for the build status
[08:06:05.366] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:05.366] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:70:0) after 1m0s
[08:07:05.439] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:70:0)
[08:07:05.439] Timer tick, asking Buildbucket for the build status
[08:07:05.522] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:05.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:71:0) after 1m0s
[08:08:05.578] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:71:0)
[08:08:05.578] Timer tick, asking Buildbucket for the build status
[08:08:05.647] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:05.647] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:72:0) after 1m0s
[08:09:05.670] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:72:0)
[08:09:05.670] Timer tick, asking Buildbucket for the build status
[08:09:06.094] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:06.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:73:0) after 1m0s
[08:10:06.135] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:73:0)
[08:10:06.135] Timer tick, asking Buildbucket for the build status
[08:10:06.203] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:06.203] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:74:0) after 1m0s
[08:11:06.227] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:74:0)
[08:11:06.227] Timer tick, asking Buildbucket for the build status
[08:11:06.310] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:06.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:75:0) after 1m0s
[08:12:06.351] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:75:0)
[08:12:06.351] Timer tick, asking Buildbucket for the build status
[08:12:06.474] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:06.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:76:0) after 1m0s
[08:13:06.561] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:76:0)
[08:13:06.561] Timer tick, asking Buildbucket for the build status
[08:13:06.659] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:06.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:77:0) after 1m0s
[08:14:06.673] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:77:0)
[08:14:06.673] Timer tick, asking Buildbucket for the build status
[08:14:06.797] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:06.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:78:0) after 1m0s
[08:15:06.879] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:78:0)
[08:15:06.879] Timer tick, asking Buildbucket for the build status
[08:15:06.952] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:06.952] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:79:0) after 1m0s
[08:16:06.977] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:79:0)
[08:16:06.978] Timer tick, asking Buildbucket for the build status
[08:16:07.047] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:07.047] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:80:0) after 1m0s
[08:17:07.054] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:80:0)
[08:17:07.054] Timer tick, asking Buildbucket for the build status
[08:17:07.182] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:07.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:81:0) after 1m0s
[08:18:07.187] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:81:0)
[08:18:07.187] Timer tick, asking Buildbucket for the build status
[08:18:07.251] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:07.251] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:82:0) after 1m0s
[08:19:07.280] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:82:0)
[08:19:07.280] Timer tick, asking Buildbucket for the build status
[08:19:07.686] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:07.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:83:0) after 1m0s
[08:20:07.723] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:83:0)
[08:20:07.723] Timer tick, asking Buildbucket for the build status
[08:20:07.793] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:07.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:84:0) after 1m0s
[08:21:07.820] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:84:0)
[08:21:07.820] Timer tick, asking Buildbucket for the build status
[08:21:07.883] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:07.884] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:85:0) after 1m0s
[08:22:07.937] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:85:0)
[08:22:07.937] Timer tick, asking Buildbucket for the build status
[08:22:08.136] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:08.136] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:86:0) after 1m0s
[08:23:08.226] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:86:0)
[08:23:08.227] Timer tick, asking Buildbucket for the build status
[08:23:08.407] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:08.407] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:87:0) after 1m0s
[08:24:08.449] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:87:0)
[08:24:08.449] Timer tick, asking Buildbucket for the build status
[08:24:08.550] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:08.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:88:0) after 1m0s
[08:25:08.589] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:88:0)
[08:25:08.589] Timer tick, asking Buildbucket for the build status
[08:25:10.102] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:10.102] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:89:0) after 1m0s
[08:26:10.180] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:89:0)
[08:26:10.180] Timer tick, asking Buildbucket for the build status
[08:26:10.306] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:10.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:90:0) after 1m0s
[08:27:10.321] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:90:0)
[08:27:10.321] Timer tick, asking Buildbucket for the build status
[08:27:10.382] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:10.382] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:91:0) after 1m0s
[08:28:10.404] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:91:0)
[08:28:10.404] Timer tick, asking Buildbucket for the build status
[08:28:10.498] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:10.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:92:0) after 1m0s
[08:29:10.570] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:92:0)
[08:29:10.571] Timer tick, asking Buildbucket for the build status
[08:29:10.683] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:10.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:93:0) after 1m0s
[08:30:10.704] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:93:0)
[08:30:10.704] Timer tick, asking Buildbucket for the build status
[08:30:10.770] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:10.770] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:94:0) after 1m0s
[08:31:10.931] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:94:0)
[08:31:10.931] Timer tick, asking Buildbucket for the build status
[08:31:10.987] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:10.987] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:95:0) after 1m0s
[08:32:11.328] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:95:0)
[08:32:11.328] Timer tick, asking Buildbucket for the build status
[08:32:11.648] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:11.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:96:0) after 1m0s
[08:33:11.718] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:96:0)
[08:33:11.718] Timer tick, asking Buildbucket for the build status
[08:33:11.834] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:11.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:97:0) after 1m0s
[08:34:12.020] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:97:0)
[08:34:12.020] Timer tick, asking Buildbucket for the build status
[08:34:12.141] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:12.141] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:98:0) after 1m0s
[08:35:12.374] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:98:0)
[08:35:12.374] Timer tick, asking Buildbucket for the build status
[08:35:12.901] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:12.901] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:99:0) after 1m0s
[08:36:12.904] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:99:0)
[08:36:12.904] Timer tick, asking Buildbucket for the build status
[08:36:13.052] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:13.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:100:0) after 1m0s
[08:37:13.187] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:100:0)
[08:37:13.187] Timer tick, asking Buildbucket for the build status
[08:37:13.370] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:13.370] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:101:0) after 1m0s
[08:38:13.413] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:101:0)
[08:38:13.413] Timer tick, asking Buildbucket for the build status
[08:38:13.896] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:13.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:102:0) after 1m0s
[08:39:14.005] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:102:0)
[08:39:14.005] Timer tick, asking Buildbucket for the build status
[08:39:14.128] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:14.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:103:0) after 1m0s
[08:40:14.146] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:103:0)
[08:40:14.146] Timer tick, asking Buildbucket for the build status
[08:40:14.402] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:14.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:104:0) after 1m0s
[08:41:14.510] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:104:0)
[08:41:14.510] Timer tick, asking Buildbucket for the build status
[08:41:14.644] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:14.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:105:0) after 1m0s
[08:42:14.666] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:105:0)
[08:42:14.666] Timer tick, asking Buildbucket for the build status
[08:42:14.790] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:14.790] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:106:0) after 1m0s
[08:43:14.948] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:106:0)
[08:43:14.948] Timer tick, asking Buildbucket for the build status
[08:43:15.064] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:15.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:107:0) after 1m0s
[08:44:15.146] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:107:0)
[08:44:15.146] Timer tick, asking Buildbucket for the build status
[08:44:15.239] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:15.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:108:0) after 1m0s
[08:45:15.374] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:108:0)
[08:45:15.374] Timer tick, asking Buildbucket for the build status
[08:45:15.533] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:15.533] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:109:0) after 1m0s
[08:46:15.603] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:109:0)
[08:46:15.603] Timer tick, asking Buildbucket for the build status
[08:46:15.917] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:15.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:110:0) after 1m0s
[08:47:16.000] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:110:0)
[08:47:16.000] Timer tick, asking Buildbucket for the build status
[08:47:16.106] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:16.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:111:0) after 1m0s
[08:48:16.271] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:111:0)
[08:48:16.271] Timer tick, asking Buildbucket for the build status
[08:48:16.367] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:16.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:112:0) after 1m0s
[08:49:16.468] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:112:0)
[08:49:16.468] Timer tick, asking Buildbucket for the build status
[08:49:17.013] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:17.013] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:113:0) after 1m0s
[08:50:17.050] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:113:0)
[08:50:17.050] Timer tick, asking Buildbucket for the build status
[08:50:17.128] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:17.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:114:0) after 1m0s
[08:51:17.156] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:114:0)
[08:51:17.156] Timer tick, asking Buildbucket for the build status
[08:51:17.290] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:17.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:115:0) after 1m0s
[08:52:17.364] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:115:0)
[08:52:17.364] Timer tick, asking Buildbucket for the build status
[08:52:17.438] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:17.438] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:116:0) after 1m0s
[08:53:17.540] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:116:0)
[08:53:17.540] Timer tick, asking Buildbucket for the build status
[08:53:17.739] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:17.739] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:117:0) after 1m0s
[08:54:17.788] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:117:0)
[08:54:17.788] Timer tick, asking Buildbucket for the build status
[08:54:17.930] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:17.931] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:118:0) after 1m0s
[08:55:18.052] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:118:0)
[08:55:18.052] Timer tick, asking Buildbucket for the build status
[08:55:18.465] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:18.465] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:119:0) after 1m0s
[08:56:18.586] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:119:0)
[08:56:18.586] Timer tick, asking Buildbucket for the build status
[08:56:18.668] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:18.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:120:0) after 1m0s
[08:57:18.821] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:120:0)
[08:57:18.821] Timer tick, asking Buildbucket for the build status
[08:57:18.888] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:18.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:121:0) after 1m0s
[08:58:19.026] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:121:0)
[08:58:19.027] Timer tick, asking Buildbucket for the build status
[08:58:19.644] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:19.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:122:0) after 1m0s
[08:59:19.630] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:122:0)
[08:59:19.630] Timer tick, asking Buildbucket for the build status
[08:59:19.748] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:19.748] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:123:0) after 1m0s
[09:00:19.803] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:123:0)
[09:00:19.803] Timer tick, asking Buildbucket for the build status
[09:00:19.916] Build 8865487668666527504: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:19.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030917730670538400:124:0) after 1m0s
[09:01:03.872] Received PubSub notification, asking Buildbucket for the build status
[09:01:04.661] Build 8865487668666527504: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:01:04.661] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1603616462663640",
"created_by": "project:chromium",
"created_ts": "1603609130184065",
"id": "8865487668666527504",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"59d6e097cda651bb22888aeda1274309534abb68\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.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\": \"59d6e097cda651bb22888aeda1274309534abb68\", \"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-32-19-8law\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"Linux CFI\", \"buildnumber\": 18760, \"got_angle_revision\": \"7a0263547cda936b320d80c650b69d7522ee1a9f\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"59d6e097cda651bb22888aeda1274309534abb68\", \"got_revision_cp\": \"refs/heads/master@{#820603}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"73fe59b55662be0ff07e79da1ece8b9e42415dca\", \"got_v8_revision_cp\": \"refs/heads/8.8.171@{#1}\", \"got_webrtc_revision\": \"3065e6ef3016a906d1db82e1d4322cbd53d43247\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32481}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"59d6e097cda651bb22888aeda1274309534abb68\", \"swarm_hashes_refs/heads/master(at){#820603}_without_patch\": {\"absl_hardening_tests\": \"64f62512e9f03cbf530bff5711b084547b2ef664\", \"accessibility_unittests\": \"3739945aa5d8bcfcbd0b29739c55080409f2ce3f\", \"angle_unittests\": \"a1749d9f60c0db4381604a60b18caf14ec8ac235\", \"app_shell_unittests\": \"da27e2fbfab45400a20fe013483ed215f9b5d2d6\", \"aura_unittests\": \"3afb3fde93f1c0fce381856dfbf640a870eeb872\", \"base_unittests\": \"6c4ed79285daf6081f34b2f9bb7e635e41abf453\", \"base_util_unittests\": \"bd7ba5f422993e3378e5f50327aef1d8f9db4923\", \"blink_common_unittests\": \"e3097465c45ca3d32b7a112b93b041b34b9846d8\", \"blink_fuzzer_unittests\": \"d57eb4db31814d594bf90d1e9fd51d10d0c6196e\", \"blink_heap_unittests\": \"858256cca36a20e79604c738e6b2dc863134fd8b\", \"blink_platform_unittests\": \"8593572019f97e29cdb38aa86b8c267a25d6a488\", \"blink_unittests\": \"5d422ab9ffe1ae740ceba233794d1c57069aca36\", \"boringssl_crypto_tests\": \"e149e781e9928a29b4dd9583f17cfba686900c7b\", \"boringssl_ssl_tests\": \"67e991e557e4bcf147544aa74198c7c6c19a1c54\", \"browser_tests\": \"aed50d567e30f0346792f076c3fbfdafd6258b1a\", \"capture_unittests\": \"c65a1e95a130051627305b7996906eee72a91638\", \"cast_unittests\": \"ae27d0c76df19edfe7c7621686230f7cee08b67e\", \"cc_unittests\": \"fc69925be7a984d981d588d8bc45ee6254e656e4\", \"chrome_app_unittests\": \"ade3b1156dbd97b671115c1b9d6cc0547122cd61\", \"chromedriver_unittests\": \"50c7fd4f5c522afd1d32ddaa5af56840833e1818\", \"components_browsertests\": \"48a82cd1dd01f75d295e560f5201ec1b4f4a940f\", \"components_unittests\": \"a0cdd21ac675d32324d0674cc418ae23d4f9c33a\", \"compositor_unittests\": \"980351779ade1d763d96a54442d9faf1278012f0\", \"content_browsertests\": \"f4c9d303cf963e6eaf1251488981edcb4bbbabd0\", \"content_unittests\": \"7bf0d47f809b2550ba94534369ff6a5bdfb3dd18\", \"cronet_tests\": \"8a6906d066bac73fdc0cab61beee5c142ccd5d27\", \"cronet_unittests\": \"6aaef5946e0b40575c7349514f6781966a6d7b2d\", \"crypto_unittests\": \"1fa4a8923d25457a5b0e23a99d4d2bede6a7ceba\", \"dbus_unittests\": \"0182c7b13835f4cce4225d6092d3350a1308b816\", \"device_unittests\": \"3bec8d43475965b7e1bf68fb4410ce35c333e28b\", \"display_unittests\": \"fe60f68ce7141d28f72f1485b74fd438a096b809\", \"events_unittests\": \"8ef9b84a71101b4167b482a24d690dfdc2136133\", \"extensions_browsertests\": \"1d1572a3945b8dc837edb29d50dc85a3f08d8fa6\", \"extensions_unittests\": \"8481e3cb2887b28ab035da930037df01b598f59b\", \"filesystem_service_unittests\": \"2bb333643bcb36a135fd6714b5f327ee11cc718d\", \"gcm_unit_tests\": \"7307effccef0d30f1cb4a52b77a464a4d6a2acbb\", \"gfx_unittests\": \"8ca44e73139ee7faf44077ac33c167ba4979ce3d\", \"gin_unittests\": \"bd528d53cfacc7a2bbf1957bc96d1be081594092\", \"gl_tests\": \"c47af5e7ca0a95d9663e174aaddf9b57fbd0e5c0\", \"gl_unittests\": \"5418abebbe792f29b70816b14c8953151b26343b\", \"google_apis_unittests\": \"d2c7c8271e96e2624cadce9a0545cffb9eff560c\", \"gpu_unittests\": \"c3115c8aebb6a0e578451d4e9bd6ffb61c70b92c\", \"gwp_asan_unittests\": \"9b4c1237e71d0d3384f222e9fd8250de35a3b406\", \"headless_browsertests\": \"66b5847ee3f431bcf2e872f8ced3700f67d575e5\", \"headless_unittests\": \"c664f6b613da99e853cddfb6e1f8874af5171286\", \"interactive_ui_tests\": \"2c6a880e6bab9c003f2f99c91bf3819e16150a5b\", \"ipc_tests\": \"a4d94a368215d9d345e814b042dcce7ac33f25ed\", \"jingle_unittests\": \"3140f400d2c1a870a3d812f629f67900d7500f63\", \"latency_unittests\": \"b9c1ec9b7ccc127eeb829a92f18bb8f9ef27990c\", \"libjingle_xmpp_unittests\": \"04bc62d64e01dd731326a93760cec313311785d2\", \"media_blink_unittests\": \"6dcbaee05d0615ce2333a519ecd314a16a7e5d45\", \"media_unittests\": \"93ca74f3a961c72da07c5a144980c49a1027ba44\", \"message_center_unittests\": \"921c6994377559e109c300c84070a3888af5958b\", \"midi_unittests\": \"0abd54edda4ebf01018e9d9c5bc061b2ad985c84\", \"mojo_core_unittests\": \"f11ade16466cc34749b7a32dbc3aca860f9a8d20\", \"mojo_unittests\": \"39af4c06160e05b9f764f997273b9cc269779dde\", \"nacl_helper_nonsfi_unittests\": \"2ee71dae2e47ae9d8a7e39a784c5186400d7319d\", \"nacl_loader_unittests\": \"dcea8fcf54aa24131ca35971cb1d75bdf20ece9a\", \"native_theme_unittests\": \"054ee7039471ff4c8835f8ad9704397c9d2a297a\", \"net_unittests\": \"653cbf6086987250af9d460b52c012a3d8f74cee\", \"pdf_unittests\": \"f3500f88e6bb5c50053ea4ddd7c632f752e0d1ed\", \"perfetto_unittests\": \"f52f5e9c31bddf461a7f0a9cc7119b1210c495d0\", \"ppapi_unittests\": \"6bc59ee10e37827aa8a7b9d2b1227d694337d94f\", \"printing_unittests\": \"bb674dd07ad20f936fda8ac49aa1208002fca6a3\", \"remoting_unittests\": \"9eb00c14e711a0efaa1cc04a1bd0599eda749693\", \"sandbox_linux_unittests\": \"7a9d081b42297dcd6d9879ba15d2147670786d1a\", \"service_manager_unittests\": \"ed6710718d1533a35d0d33ffb196c22619004ac8\", \"services_unittests\": \"f0e2e0f69c41b0d6c85d43cb9d0068fd9fea1721\", \"shell_dialogs_unittests\": \"e4bff8ce0fb6fc46da259adad2bbdee2914f6fe4\", \"skia_unittests\": \"ca5c1aea2304b33ea083b8bf3f9eb9c73ba02bd5\", \"snapshot_unittests\": \"66db5e292f8d7388c0414476fde57a1efe64f134\", \"sql_unittests\": \"6824602b65e1d34bad5d7b33da6d089fb19ad4af\", \"storage_unittests\": \"f874edb50690193e000388e9bc97b52cdefa793d\", \"sync_integration_tests\": \"dfbaa5c4ccce3ffdb2286e26d4a3c51ce962ea5b\", \"traffic_annotation_auditor_unittests\": \"955e2c3d311b7a44b732e8f58efc6c360097ab94\", \"ui_base_unittests\": \"84f91b4639b051ee7fd75b52304588ecf1e87ab2\", \"ui_touch_selection_unittests\": \"1b7e23a66aa7008855db2c464e6d7e37e809b9d1\", \"unit_tests\": \"f6201db36c973242f61b313676ec24a0ecb63b8f\", \"url_unittests\": \"f939f523c4c4deb05921789ac76b9aaf5d747b47\", \"views_unittests\": \"43e4f9aa672c3a2e22670613500b221232fdc029\", \"viz_unittests\": \"a7fe9dc2d812f1daa50efb0a0cff2be949ceb7df\", \"vr_common_unittests\": \"926f2254b73d47b64540e91f9ca21f0245c335bf\", \"vr_pixeltests\": \"97214a7b8c5721f6c7109cc0722d29594205a5fb\", \"wm_unittests\": \"04b23e51bdcffd23e60a82ce83b7acc3e29fdea3\", \"wtf_unittests\": \"14cc959b47235f1eea6d42d826a7e4c537c3569e\", \"zlib_unittests\": \"742eb25b54aa81e53626b9a97f5900e337217451\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-19-8law\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603609190266899",
"status": "COMPLETED",
"status_changed_ts": "1603616463009404",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/18760",
"builder:Linux CFI",
"buildset:commit/git/59d6e097cda651bb22888aeda1274309534abb68",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/59d6e097cda651bb22888aeda1274309534abb68",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030917730670538400",
"scheduler_job_id:chromium/Linux CFI",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865487668666527504/+/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:4f775f00099d5010",
"user_agent:luci-scheduler"
],
"updated_ts": "1603616463027359",
"url": "https://ci.chromium.org/b/8865487668666527504",
"utcnow_ts": "1603616464650874"
}
}
[09:01:04.661] Invocation finished in 2h2m15.772118184s with status SUCCEEDED