[15:21:44.886] New invocation is queued and will start shortly
[15:21:46.016] Starting the invocation (attempt 1)
[15:21:46.050] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:21:46.050] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:21:46.050] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018836692328122320",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a6a96ac9553d3ebc86071c226a0c9e1ae17a0b5b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9018836692328122320",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/a6a96ac9553d3ebc86071c226a0c9e1ae17a0b5b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a6a96ac9553d3ebc86071c226a0c9e1ae17a0b5b",
"gitiles_ref:refs/heads/master"
]
}
[15:21:47.297] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615130506190238",
"id": "8853406630299798688",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a6a96ac9553d3ebc86071c226a0c9e1ae17a0b5b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615130506999688",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/19875",
"builder:Linux CFI",
"buildset:commit/git/a6a96ac9553d3ebc86071c226a0c9e1ae17a0b5b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a6a96ac9553d3ebc86071c226a0c9e1ae17a0b5b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018836692328122320",
"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/8853406630299798688/+/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": "1615130507000120",
"url": "https://ci.chromium.org/b/8853406630299798688",
"utcnow_ts": "1615130507256906"
}
}
[15:21:47.297] Task URL: https://ci.chromium.org/b/8853406630299798688
[15:21:47.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:2:0) after 1m0s
[15:22:02.469] Received PubSub notification, asking Buildbucket for the build status
[15:22:02.536] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:47.523] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:2:0)
[15:22:47.523] Timer tick, asking Buildbucket for the build status
[15:22:47.593] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:47.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:4:0) after 1m0s
[15:23:47.651] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:4:0)
[15:23:47.651] Timer tick, asking Buildbucket for the build status
[15:23:47.713] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:47.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:5:0) after 1m0s
[15:24:47.739] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:5:0)
[15:24:47.739] Timer tick, asking Buildbucket for the build status
[15:24:47.807] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:47.807] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:6:0) after 1m0s
[15:25:47.820] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:6:0)
[15:25:47.820] Timer tick, asking Buildbucket for the build status
[15:25:47.883] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:47.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:7:0) after 1m0s
[15:26:47.919] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:7:0)
[15:26:47.919] Timer tick, asking Buildbucket for the build status
[15:26:47.984] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:47.984] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:8:0) after 1m0s
[15:27:48.065] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:8:0)
[15:27:48.065] Timer tick, asking Buildbucket for the build status
[15:27:48.240] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:48.240] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:9:0) after 1m0s
[15:28:48.256] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:9:0)
[15:28:48.256] Timer tick, asking Buildbucket for the build status
[15:28:48.326] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:48.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:10:0) after 1m0s
[15:29:48.382] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:10:0)
[15:29:48.382] Timer tick, asking Buildbucket for the build status
[15:29:48.447] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:48.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:11:0) after 1m0s
[15:30:48.471] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:11:0)
[15:30:48.471] Timer tick, asking Buildbucket for the build status
[15:30:48.534] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:48.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:12:0) after 1m0s
[15:31:48.550] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:12:0)
[15:31:48.550] Timer tick, asking Buildbucket for the build status
[15:31:48.664] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:48.664] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:13:0) after 1m0s
[15:32:48.680] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:13:0)
[15:32:48.680] Timer tick, asking Buildbucket for the build status
[15:32:48.805] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:48.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:14:0) after 1m0s
[15:33:48.819] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:14:0)
[15:33:48.819] Timer tick, asking Buildbucket for the build status
[15:33:48.923] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:48.923] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:15:0) after 1m0s
[15:34:48.939] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:15:0)
[15:34:48.939] Timer tick, asking Buildbucket for the build status
[15:34:49.010] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:49.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:16:0) after 1m0s
[15:35:49.030] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:16:0)
[15:35:49.030] Timer tick, asking Buildbucket for the build status
[15:35:49.100] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:49.100] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:17:0) after 1m0s
[15:36:49.119] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:17:0)
[15:36:49.119] Timer tick, asking Buildbucket for the build status
[15:36:49.329] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:49.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:18:0) after 1m0s
[15:37:49.368] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:18:0)
[15:37:49.369] Timer tick, asking Buildbucket for the build status
[15:37:49.458] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:49.458] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:19:0) after 1m0s
[15:38:49.529] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:19:0)
[15:38:49.529] Timer tick, asking Buildbucket for the build status
[15:38:49.598] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:49.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:20:0) after 1m0s
[15:39:49.683] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:20:0)
[15:39:49.683] Timer tick, asking Buildbucket for the build status
[15:39:49.854] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:49.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:21:0) after 1m0s
[15:40:49.887] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:21:0)
[15:40:49.887] Timer tick, asking Buildbucket for the build status
[15:40:50.014] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:50.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:22:0) after 1m0s
[15:41:50.078] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:22:0)
[15:41:50.078] Timer tick, asking Buildbucket for the build status
[15:41:50.243] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:50.243] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:23:0) after 1m0s
[15:42:50.258] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:23:0)
[15:42:50.258] Timer tick, asking Buildbucket for the build status
[15:42:50.460] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:50.460] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:24:0) after 1m0s
[15:43:50.515] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:24:0)
[15:43:50.515] Timer tick, asking Buildbucket for the build status
[15:43:50.595] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:50.595] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:25:0) after 1m0s
[15:44:50.613] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:25:0)
[15:44:50.613] Timer tick, asking Buildbucket for the build status
[15:44:50.695] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:50.695] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:26:0) after 1m0s
[15:45:50.709] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:26:0)
[15:45:50.709] Timer tick, asking Buildbucket for the build status
[15:45:50.828] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:50.828] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:27:0) after 1m0s
[15:46:50.844] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:27:0)
[15:46:50.844] Timer tick, asking Buildbucket for the build status
[15:46:51.122] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:51.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:28:0) after 1m0s
[15:47:51.139] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:28:0)
[15:47:51.139] Timer tick, asking Buildbucket for the build status
[15:47:51.213] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:51.213] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:29:0) after 1m0s
[15:48:51.273] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:29:0)
[15:48:51.273] Timer tick, asking Buildbucket for the build status
[15:48:51.353] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:51.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:30:0) after 1m0s
[15:49:51.367] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:30:0)
[15:49:51.367] Timer tick, asking Buildbucket for the build status
[15:49:51.451] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:51.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:31:0) after 1m0s
[15:50:51.574] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:31:0)
[15:50:51.574] Timer tick, asking Buildbucket for the build status
[15:50:51.705] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:51.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:32:0) after 1m0s
[15:51:51.822] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:32:0)
[15:51:51.822] Timer tick, asking Buildbucket for the build status
[15:51:52.016] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:52.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:33:0) after 1m0s
[15:52:52.081] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:33:0)
[15:52:52.081] Timer tick, asking Buildbucket for the build status
[15:52:52.315] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:52.315] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:34:0) after 1m0s
[15:53:52.329] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:34:0)
[15:53:52.329] Timer tick, asking Buildbucket for the build status
[15:53:52.821] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:52.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:35:0) after 1m0s
[15:54:52.873] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:35:0)
[15:54:52.873] Timer tick, asking Buildbucket for the build status
[15:54:53.104] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:53.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:36:0) after 1m0s
[15:55:53.107] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:36:0)
[15:55:53.107] Timer tick, asking Buildbucket for the build status
[15:55:53.176] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:53.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:37:0) after 1m0s
[15:56:53.193] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:37:0)
[15:56:53.193] Timer tick, asking Buildbucket for the build status
[15:56:54.034] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:54.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:38:0) after 1m0s
[15:57:54.622] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:38:0)
[15:57:54.622] Timer tick, asking Buildbucket for the build status
[15:57:54.750] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:54.750] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:39:0) after 1m0s
[15:58:58.005] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:39:0)
[15:58:58.005] Timer tick, asking Buildbucket for the build status
[15:58:58.121] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:58.121] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:40:0) after 1m0s
[15:59:58.308] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:40:0)
[15:59:58.308] Timer tick, asking Buildbucket for the build status
[15:59:58.366] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:58.366] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:41:0) after 1m0s
[16:00:58.430] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:41:0)
[16:00:58.430] Timer tick, asking Buildbucket for the build status
[16:00:58.606] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:58.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:42:0) after 1m0s
[16:01:59.532] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:42:0)
[16:01:59.532] Timer tick, asking Buildbucket for the build status
[16:01:59.598] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:59.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:43:0) after 1m0s
[16:02:59.775] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:43:0)
[16:02:59.775] Timer tick, asking Buildbucket for the build status
[16:02:59.850] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:59.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:44:0) after 1m0s
[16:04:00.184] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:44:0)
[16:04:00.184] Timer tick, asking Buildbucket for the build status
[16:04:00.300] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:00.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:45:0) after 1m0s
[16:05:00.505] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:45:0)
[16:05:00.505] Timer tick, asking Buildbucket for the build status
[16:05:00.680] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:00.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:46:0) after 1m0s
[16:06:00.663] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:46:0)
[16:06:00.663] Timer tick, asking Buildbucket for the build status
[16:06:00.801] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:00.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:47:0) after 1m0s
[16:07:01.016] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:47:0)
[16:07:01.016] Timer tick, asking Buildbucket for the build status
[16:07:01.300] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:01.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:48:0) after 1m0s
[16:08:01.710] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:48:0)
[16:08:01.710] Timer tick, asking Buildbucket for the build status
[16:08:01.769] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:01.770] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:49:0) after 1m0s
[16:09:02.096] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:49:0)
[16:09:02.096] Timer tick, asking Buildbucket for the build status
[16:09:02.182] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:02.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:50:0) after 1m0s
[16:10:02.297] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:50:0)
[16:10:02.297] Timer tick, asking Buildbucket for the build status
[16:10:02.373] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:02.373] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:51:0) after 1m0s
[16:11:02.391] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:51:0)
[16:11:02.391] Timer tick, asking Buildbucket for the build status
[16:11:02.656] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:02.656] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:52:0) after 1m0s
[16:12:02.756] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:52:0)
[16:12:02.756] Timer tick, asking Buildbucket for the build status
[16:12:03.451] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:03.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:53:0) after 1m0s
[16:13:03.615] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:53:0)
[16:13:03.615] Timer tick, asking Buildbucket for the build status
[16:13:03.912] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:03.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:54:0) after 1m0s
[16:14:03.974] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:54:0)
[16:14:03.974] Timer tick, asking Buildbucket for the build status
[16:14:04.262] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:04.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:55:0) after 1m0s
[16:15:04.372] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:55:0)
[16:15:04.372] Timer tick, asking Buildbucket for the build status
[16:15:04.646] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:04.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:56:0) after 1m0s
[16:16:04.719] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:56:0)
[16:16:04.719] Timer tick, asking Buildbucket for the build status
[16:16:04.850] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:04.850] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:57:0) after 1m0s
[16:17:04.927] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:57:0)
[16:17:04.927] Timer tick, asking Buildbucket for the build status
[16:17:05.004] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:05.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:58:0) after 1m0s
[16:18:05.001] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:58:0)
[16:18:05.001] Timer tick, asking Buildbucket for the build status
[16:18:05.080] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:05.080] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:59:0) after 1m0s
[16:19:05.272] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:59:0)
[16:19:05.272] Timer tick, asking Buildbucket for the build status
[16:19:05.359] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:05.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:60:0) after 1m0s
[16:20:05.377] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:60:0)
[16:20:05.377] Timer tick, asking Buildbucket for the build status
[16:20:05.491] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:05.491] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:61:0) after 1m0s
[16:21:05.604] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:61:0)
[16:21:05.604] Timer tick, asking Buildbucket for the build status
[16:21:05.678] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:05.678] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:62:0) after 1m0s
[16:22:05.765] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:62:0)
[16:22:05.765] Timer tick, asking Buildbucket for the build status
[16:22:05.830] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:05.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:63:0) after 1m0s
[16:23:05.896] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:63:0)
[16:23:05.896] Timer tick, asking Buildbucket for the build status
[16:23:06.306] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:06.306] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:64:0) after 1m0s
[16:24:06.424] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:64:0)
[16:24:06.424] Timer tick, asking Buildbucket for the build status
[16:24:06.631] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:06.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:65:0) after 1m0s
[16:25:06.673] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:65:0)
[16:25:06.673] Timer tick, asking Buildbucket for the build status
[16:25:06.797] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:06.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:66:0) after 1m0s
[16:26:06.807] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:66:0)
[16:26:06.807] Timer tick, asking Buildbucket for the build status
[16:26:06.890] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:06.890] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:67:0) after 1m0s
[16:27:07.341] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:67:0)
[16:27:07.341] Timer tick, asking Buildbucket for the build status
[16:27:07.412] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:07.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:68:0) after 1m0s
[16:28:07.510] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:68:0)
[16:28:07.510] Timer tick, asking Buildbucket for the build status
[16:28:07.742] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:07.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:69:0) after 1m0s
[16:29:07.825] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:69:0)
[16:29:07.825] Timer tick, asking Buildbucket for the build status
[16:29:07.885] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:07.885] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:70:0) after 1m0s
[16:30:08.002] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:70:0)
[16:30:08.002] Timer tick, asking Buildbucket for the build status
[16:30:08.165] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:08.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:71:0) after 1m0s
[16:31:08.784] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:71:0)
[16:31:08.784] Timer tick, asking Buildbucket for the build status
[16:31:08.848] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:08.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:72:0) after 1m0s
[16:32:08.870] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:72:0)
[16:32:08.870] Timer tick, asking Buildbucket for the build status
[16:32:09.043] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:09.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:73:0) after 1m0s
[16:33:09.060] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:73:0)
[16:33:09.060] Timer tick, asking Buildbucket for the build status
[16:33:09.125] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:09.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:74:0) after 1m0s
[16:34:09.179] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:74:0)
[16:34:09.179] Timer tick, asking Buildbucket for the build status
[16:34:09.243] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:09.243] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:75:0) after 1m0s
[16:35:09.310] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:75:0)
[16:35:09.310] Timer tick, asking Buildbucket for the build status
[16:35:09.388] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:09.388] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:76:0) after 1m0s
[16:36:09.463] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:76:0)
[16:36:09.463] Timer tick, asking Buildbucket for the build status
[16:36:09.629] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:09.629] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:77:0) after 1m0s
[16:37:09.735] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:77:0)
[16:37:09.735] Timer tick, asking Buildbucket for the build status
[16:37:09.811] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:09.811] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:78:0) after 1m0s
[16:38:10.069] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:78:0)
[16:38:10.069] Timer tick, asking Buildbucket for the build status
[16:38:10.224] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:10.224] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:79:0) after 1m0s
[16:39:10.319] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:79:0)
[16:39:10.319] Timer tick, asking Buildbucket for the build status
[16:39:10.456] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:10.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:80:0) after 1m0s
[16:40:10.549] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:80:0)
[16:40:10.549] Timer tick, asking Buildbucket for the build status
[16:40:10.639] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:10.639] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:81:0) after 1m0s
[16:41:10.670] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:81:0)
[16:41:10.670] Timer tick, asking Buildbucket for the build status
[16:41:10.755] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:10.755] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:82:0) after 1m0s
[16:42:10.789] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:82:0)
[16:42:10.789] Timer tick, asking Buildbucket for the build status
[16:42:10.854] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:10.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:83:0) after 1m0s
[16:43:10.871] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:83:0)
[16:43:10.871] Timer tick, asking Buildbucket for the build status
[16:43:10.936] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:10.936] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:84:0) after 1m0s
[16:44:11.159] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:84:0)
[16:44:11.159] Timer tick, asking Buildbucket for the build status
[16:44:11.251] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:11.251] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:85:0) after 1m0s
[16:45:11.435] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:85:0)
[16:45:11.435] Timer tick, asking Buildbucket for the build status
[16:45:12.282] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:12.282] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:86:0) after 1m0s
[16:46:12.487] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:86:0)
[16:46:12.487] Timer tick, asking Buildbucket for the build status
[16:46:12.726] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:12.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:87:0) after 1m0s
[16:47:12.858] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:87:0)
[16:47:12.858] Timer tick, asking Buildbucket for the build status
[16:47:12.918] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:12.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:88:0) after 1m0s
[16:48:12.897] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:88:0)
[16:48:12.897] Timer tick, asking Buildbucket for the build status
[16:48:12.966] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:12.966] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:89:0) after 1m0s
[16:49:13.095] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:89:0)
[16:49:13.095] Timer tick, asking Buildbucket for the build status
[16:49:13.350] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:13.350] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:90:0) after 1m0s
[16:50:13.385] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:90:0)
[16:50:13.385] Timer tick, asking Buildbucket for the build status
[16:50:13.696] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:13.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:91:0) after 1m0s
[16:51:13.853] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:91:0)
[16:51:13.853] Timer tick, asking Buildbucket for the build status
[16:51:13.927] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:13.927] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:92:0) after 1m0s
[16:52:14.010] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:92:0)
[16:52:14.010] Timer tick, asking Buildbucket for the build status
[16:52:14.142] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:14.142] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:93:0) after 1m0s
[16:53:14.173] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:93:0)
[16:53:14.173] Timer tick, asking Buildbucket for the build status
[16:53:14.237] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:14.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:94:0) after 1m0s
[16:54:14.432] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:94:0)
[16:54:14.433] Timer tick, asking Buildbucket for the build status
[16:54:14.817] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:14.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:95:0) after 1m0s
[16:55:14.886] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:95:0)
[16:55:14.886] Timer tick, asking Buildbucket for the build status
[16:55:14.972] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:14.972] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:96:0) after 1m0s
[16:56:16.293] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:96:0)
[16:56:16.293] Timer tick, asking Buildbucket for the build status
[16:56:16.514] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:16.514] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:97:0) after 1m0s
[16:57:16.488] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:97:0)
[16:57:16.488] Timer tick, asking Buildbucket for the build status
[16:57:16.646] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:16.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:98:0) after 1m0s
[16:58:16.715] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:98:0)
[16:58:16.715] Timer tick, asking Buildbucket for the build status
[16:58:16.809] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:16.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:99:0) after 1m0s
[16:59:16.862] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:99:0)
[16:59:16.862] Timer tick, asking Buildbucket for the build status
[16:59:17.038] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:17.038] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:100:0) after 1m0s
[17:00:17.104] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:100:0)
[17:00:17.104] Timer tick, asking Buildbucket for the build status
[17:00:17.182] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:17.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:101:0) after 1m0s
[17:01:17.232] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:101:0)
[17:01:17.232] Timer tick, asking Buildbucket for the build status
[17:01:17.357] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:17.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:102:0) after 1m0s
[17:02:17.378] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:102:0)
[17:02:17.378] Timer tick, asking Buildbucket for the build status
[17:02:17.456] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:17.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:103:0) after 1m0s
[17:03:17.519] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:103:0)
[17:03:17.519] Timer tick, asking Buildbucket for the build status
[17:03:17.610] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:17.610] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:104:0) after 1m0s
[17:04:17.667] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:104:0)
[17:04:17.667] Timer tick, asking Buildbucket for the build status
[17:04:17.743] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:17.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:105:0) after 1m0s
[17:05:17.750] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:105:0)
[17:05:17.750] Timer tick, asking Buildbucket for the build status
[17:05:17.827] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:17.827] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:106:0) after 1m0s
[17:06:17.844] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:106:0)
[17:06:17.844] Timer tick, asking Buildbucket for the build status
[17:06:17.903] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:17.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:107:0) after 1m0s
[17:07:17.925] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:107:0)
[17:07:17.925] Timer tick, asking Buildbucket for the build status
[17:07:18.126] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:18.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:108:0) after 1m0s
[17:08:18.179] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:108:0)
[17:08:18.179] Timer tick, asking Buildbucket for the build status
[17:08:18.255] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:18.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:109:0) after 1m0s
[17:09:18.309] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:109:0)
[17:09:18.309] Timer tick, asking Buildbucket for the build status
[17:09:18.367] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:18.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:110:0) after 1m0s
[17:10:18.400] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:110:0)
[17:10:18.400] Timer tick, asking Buildbucket for the build status
[17:10:18.474] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:18.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:111:0) after 1m0s
[17:11:18.527] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:111:0)
[17:11:18.527] Timer tick, asking Buildbucket for the build status
[17:11:18.606] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:18.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:112:0) after 1m0s
[17:12:18.728] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:112:0)
[17:12:18.728] Timer tick, asking Buildbucket for the build status
[17:12:18.805] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:18.805] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:113:0) after 1m0s
[17:13:18.918] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:113:0)
[17:13:18.918] Timer tick, asking Buildbucket for the build status
[17:13:18.992] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:18.992] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:114:0) after 1m0s
[17:14:19.008] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:114:0)
[17:14:19.008] Timer tick, asking Buildbucket for the build status
[17:14:19.074] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:19.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:115:0) after 1m0s
[17:15:19.095] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:115:0)
[17:15:19.095] Timer tick, asking Buildbucket for the build status
[17:15:19.157] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:19.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:116:0) after 1m0s
[17:16:19.172] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:116:0)
[17:16:19.172] Timer tick, asking Buildbucket for the build status
[17:16:19.254] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:19.254] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:117:0) after 1m0s
[17:17:19.886] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:117:0)
[17:17:19.886] Timer tick, asking Buildbucket for the build status
[17:17:20.051] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:20.051] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:118:0) after 1m0s
[17:18:23.222] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:118:0)
[17:18:23.222] Timer tick, asking Buildbucket for the build status
[17:18:23.353] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:23.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:119:0) after 1m0s
[17:19:23.386] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:119:0)
[17:19:23.386] Timer tick, asking Buildbucket for the build status
[17:19:23.456] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:23.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:120:0) after 1m0s
[17:20:23.500] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:120:0)
[17:20:23.500] Timer tick, asking Buildbucket for the build status
[17:20:23.562] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:23.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:121:0) after 1m0s
[17:21:23.617] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:121:0)
[17:21:23.617] Timer tick, asking Buildbucket for the build status
[17:21:23.756] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:23.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:122:0) after 1m0s
[17:22:23.827] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:122:0)
[17:22:23.827] Timer tick, asking Buildbucket for the build status
[17:22:24.011] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:24.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:123:0) after 1m0s
[17:23:24.068] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:123:0)
[17:23:24.068] Timer tick, asking Buildbucket for the build status
[17:23:24.892] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:24.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:124:0) after 1m0s
[17:24:24.923] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:124:0)
[17:24:24.923] Timer tick, asking Buildbucket for the build status
[17:24:25.029] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:25.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:125:0) after 1m0s
[17:25:25.129] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:125:0)
[17:25:25.129] Timer tick, asking Buildbucket for the build status
[17:25:25.190] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:25.190] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:126:0) after 1m0s
[17:26:25.389] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:126:0)
[17:26:25.389] Timer tick, asking Buildbucket for the build status
[17:26:25.626] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:25.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:127:0) after 1m0s
[17:27:25.665] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:127:0)
[17:27:25.665] Timer tick, asking Buildbucket for the build status
[17:27:25.756] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:25.756] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:128:0) after 1m0s
[17:28:25.776] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:128:0)
[17:28:25.776] Timer tick, asking Buildbucket for the build status
[17:28:25.839] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:25.839] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:129:0) after 1m0s
[17:29:25.891] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:129:0)
[17:29:25.891] Timer tick, asking Buildbucket for the build status
[17:29:26.002] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:26.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:130:0) after 1m0s
[17:30:26.039] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:130:0)
[17:30:26.039] Timer tick, asking Buildbucket for the build status
[17:30:26.105] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:26.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:131:0) after 1m0s
[17:31:26.251] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:131:0)
[17:31:26.251] Timer tick, asking Buildbucket for the build status
[17:31:26.336] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:26.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:132:0) after 1m0s
[17:32:26.431] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:132:0)
[17:32:26.431] Timer tick, asking Buildbucket for the build status
[17:32:26.490] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:26.490] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:133:0) after 1m0s
[17:33:26.646] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:133:0)
[17:33:26.646] Timer tick, asking Buildbucket for the build status
[17:33:27.001] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:27.001] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:134:0) after 1m0s
[17:34:27.073] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:134:0)
[17:34:27.073] Timer tick, asking Buildbucket for the build status
[17:34:27.320] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:27.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:135:0) after 1m0s
[17:35:27.394] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:135:0)
[17:35:27.394] Timer tick, asking Buildbucket for the build status
[17:35:27.472] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:27.472] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:136:0) after 1m0s
[17:36:27.445] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:136:0)
[17:36:27.445] Timer tick, asking Buildbucket for the build status
[17:36:27.859] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:27.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:137:0) after 1m0s
[17:37:27.936] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:137:0)
[17:37:27.936] Timer tick, asking Buildbucket for the build status
[17:37:28.305] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:28.305] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:138:0) after 1m0s
[17:38:28.321] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:138:0)
[17:38:28.321] Timer tick, asking Buildbucket for the build status
[17:38:28.445] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:28.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:139:0) after 1m0s
[17:39:28.492] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:139:0)
[17:39:28.492] Timer tick, asking Buildbucket for the build status
[17:39:28.712] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:28.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:140:0) after 1m0s
[17:40:28.789] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:140:0)
[17:40:28.789] Timer tick, asking Buildbucket for the build status
[17:40:29.049] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:29.049] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:141:0) after 1m0s
[17:41:29.090] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:141:0)
[17:41:29.090] Timer tick, asking Buildbucket for the build status
[17:41:29.444] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:29.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:142:0) after 1m0s
[17:42:29.607] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:142:0)
[17:42:29.607] Timer tick, asking Buildbucket for the build status
[17:42:29.737] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:29.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:143:0) after 1m0s
[17:43:29.784] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:143:0)
[17:43:29.784] Timer tick, asking Buildbucket for the build status
[17:43:29.857] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:29.857] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:144:0) after 1m0s
[17:44:29.860] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:144:0)
[17:44:29.860] Timer tick, asking Buildbucket for the build status
[17:44:29.962] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:29.962] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:145:0) after 1m0s
[17:45:30.105] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:145:0)
[17:45:30.105] Timer tick, asking Buildbucket for the build status
[17:45:30.313] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:30.313] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:146:0) after 1m0s
[17:46:30.338] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:146:0)
[17:46:30.338] Timer tick, asking Buildbucket for the build status
[17:46:30.430] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:30.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:147:0) after 1m0s
[17:47:30.459] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:147:0)
[17:47:30.459] Timer tick, asking Buildbucket for the build status
[17:47:30.531] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:30.531] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:148:0) after 1m0s
[17:48:30.584] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:148:0)
[17:48:30.584] Timer tick, asking Buildbucket for the build status
[17:48:30.679] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:30.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:149:0) after 1m0s
[17:49:30.726] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:149:0)
[17:49:30.726] Timer tick, asking Buildbucket for the build status
[17:49:30.872] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:30.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:150:0) after 1m0s
[17:50:30.900] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:150:0)
[17:50:30.900] Timer tick, asking Buildbucket for the build status
[17:50:30.969] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:30.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:151:0) after 1m0s
[17:51:30.991] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:151:0)
[17:51:30.991] Timer tick, asking Buildbucket for the build status
[17:51:31.117] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:31.117] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:152:0) after 1m0s
[17:52:31.138] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:152:0)
[17:52:31.138] Timer tick, asking Buildbucket for the build status
[17:52:31.256] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:31.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:153:0) after 1m0s
[17:53:31.273] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:153:0)
[17:53:31.273] Timer tick, asking Buildbucket for the build status
[17:53:31.345] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:31.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:154:0) after 1m0s
[17:54:31.365] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:154:0)
[17:54:31.365] Timer tick, asking Buildbucket for the build status
[17:54:31.435] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:31.435] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:155:0) after 1m0s
[17:55:31.531] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:155:0)
[17:55:31.531] Timer tick, asking Buildbucket for the build status
[17:55:31.606] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:31.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:156:0) after 1m0s
[17:56:31.645] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:156:0)
[17:56:31.645] Timer tick, asking Buildbucket for the build status
[17:56:32.259] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:32.259] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:157:0) after 1m0s
[17:57:32.444] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:157:0)
[17:57:32.444] Timer tick, asking Buildbucket for the build status
[17:57:32.721] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:32.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:158:0) after 1m0s
[17:58:32.857] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:158:0)
[17:58:32.857] Timer tick, asking Buildbucket for the build status
[17:58:32.933] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:32.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:159:0) after 1m0s
[17:59:32.985] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:159:0)
[17:59:32.985] Timer tick, asking Buildbucket for the build status
[17:59:33.076] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:33.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:160:0) after 1m0s
[18:00:33.134] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:160:0)
[18:00:33.134] Timer tick, asking Buildbucket for the build status
[18:00:33.219] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:33.219] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:161:0) after 1m0s
[18:01:33.299] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:161:0)
[18:01:33.299] Timer tick, asking Buildbucket for the build status
[18:01:33.512] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:33.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:162:0) after 1m0s
[18:02:33.585] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:162:0)
[18:02:33.585] Timer tick, asking Buildbucket for the build status
[18:02:33.832] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:33.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:163:0) after 1m0s
[18:03:33.888] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:163:0)
[18:03:33.888] Timer tick, asking Buildbucket for the build status
[18:03:34.221] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:34.221] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:164:0) after 1m0s
[18:04:34.256] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:164:0)
[18:04:34.256] Timer tick, asking Buildbucket for the build status
[18:04:34.539] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:34.539] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:165:0) after 1m0s
[18:05:34.574] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:165:0)
[18:05:34.574] Timer tick, asking Buildbucket for the build status
[18:05:34.655] Build 8853406630299798688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:34.655] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9018836692328122320:166:0) after 1m0s
[18:06:32.965] Received PubSub notification, asking Buildbucket for the build status
[18:06:33.359] Build 8853406630299798688: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:06:33.359] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615140391108937",
"created_by": "project:chromium",
"created_ts": "1615130506190238",
"id": "8853406630299798688",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a6a96ac9553d3ebc86071c226a0c9e1ae17a0b5b\"}}",
"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\": \"a6a96ac9553d3ebc86071c226a0c9e1ae17a0b5b\", \"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-14-t47x\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"Linux CFI\", \"buildnumber\": 19875, \"got_angle_revision\": \"9bc86c50f283560a3294c256bacccc1accb5bc94\", \"got_dawn_revision\": \"010fd1a8d7c7dd4e8fabe73546be78c45b6419c2\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"a6a96ac9553d3ebc86071c226a0c9e1ae17a0b5b\", \"got_revision_cp\": \"refs/heads/master@{#860590}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"de7d5775ab25234a2c14d061e0cda342248a0e6d\", \"got_v8_revision\": \"f8b883fbba96b155409eb00da93826216bea9fc0\", \"got_v8_revision_cp\": \"refs/heads/9.1.60@{#1}\", \"got_webrtc_revision\": \"3208bf102b75e8ec1eaa6640dfa3b545310b1e02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33382}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux_chromium_cfi_rel_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a6a96ac9553d3ebc86071c226a0c9e1ae17a0b5b\", \"swarm_hashes_refs/heads/master(at){#860590}_without_patch\": {\"absl_hardening_tests\": \"e90fd063e3939a3b177ae50b5932a54ddc4deed8\", \"accessibility_unittests\": \"c9b497ccaf7b21f35cdfb251887dbf55027dc38b\", \"angle_unittests\": \"10814b2dc7e003f4a0f79afc03dc4f53c94930f8\", \"app_shell_unittests\": \"a645bc7884f9583069bb56d9897ea1009475b398\", \"aura_unittests\": \"792c75bad5303e13867ce3f0919f1150b734d133\", \"base_unittests\": \"5fda5d69905c2cbabd128bbe5c64633533e7299f\", \"base_util_unittests\": \"0883bdda1be2169f0ec2a742ec580366877a94f4\", \"blink_common_unittests\": \"9a9a5e032a31ee2e76dd857411b79565518a9acc\", \"blink_fuzzer_unittests\": \"6c2426aad6eab0b55a8e99140b32d4bd8012ff64\", \"blink_heap_unittests\": \"ad7f177f000fd24be31d698de2f1118c7bd3d3ac\", \"blink_platform_unittests\": \"2e694c1e84319ca5c7f0fd645487caffa0cd0c74\", \"blink_unittests\": \"36e8a6c46dd4ed75011c8cc31e02422adfb4c49a\", \"boringssl_crypto_tests\": \"751d69270e62a5dd0df0d6ed4cb6d0d9e5ccd0a2\", \"boringssl_ssl_tests\": \"467f0b04085d963b410b64e18ddb6986d8634c4e\", \"browser_tests\": \"bc5b6c45933581e2a6ba9965ca4ac9678d8cbac1\", \"capture_unittests\": \"f7607ec1fa9381b95ca958b395aa489cc39d2a38\", \"cast_unittests\": \"ddf427ff842ad4f8342029569437e1641e9854eb\", \"cc_unittests\": \"80c7c0ffc590558c45cf623416766f96ea68d851\", \"chrome_app_unittests\": \"7ca49d26a19b24fec15f23c83df24b58f546a56a\", \"chromedriver_unittests\": \"517ed7bddae8f179623c0353650e4e0ac6c53518\", \"color_unittests\": \"7c21504474e08dab47f3676d595848a7b51692d0\", \"components_browsertests\": \"adf12998e1ec67456aaf13b6719e597a8285f28c\", \"components_unittests\": \"a6659339f10d3981f4c06f7cc1eb312a95fde891\", \"compositor_unittests\": \"d869bf72fd945a6458bab0b6a64bdca12a14b756\", \"content_browsertests\": \"e0df5bae2b3015ca21f1e1e0f2a063007f6efab7\", \"content_unittests\": \"55606a26c4e57706f53f971218bb7888d111f6f6\", \"cronet_tests\": \"266d01135d6f73b724bfe76d088c9f7e621b6d5d\", \"cronet_unittests\": \"6b33334921ff579d7374595df8aa0b519e810638\", \"crypto_unittests\": \"7ff0b1daa0aab59fffb7ba97caecbdb86d4e41fb\", \"dbus_unittests\": \"28c71680b9fe23495febc9e43e3005732664da78\", \"device_unittests\": \"c689e55e0d6ce7fa9e6230d63c9de5bd23c2d8a4\", \"display_unittests\": \"212739fb7a24c7aedf7a32c1c04d5bfdec877b36\", \"events_unittests\": \"7e9cdd1d4e5ab0bd5154649175bd0869e516cb1f\", \"extensions_browsertests\": \"2261b86243c9ed78265af16fb079d872d1478a48\", \"extensions_unittests\": \"c5776e62251f308e00d87923ca5eddce8977612a\", \"filesystem_service_unittests\": \"489b22641b078d9c01be78c5e878fc6123eb6c5a\", \"gcm_unit_tests\": \"d2d6bf67f9e3fec53c6444e4a23271df3f4f2fe2\", \"gfx_unittests\": \"44ebe179c81aec1e7631e5fdd28aded2b36db992\", \"gin_unittests\": \"a786140b708892fc9c6dc96c24f51a2d3d4229b7\", \"gl_tests\": \"89938bc566cdb949dec0d05d7f52f0a5909132ea\", \"gl_unittests\": \"6cfde25456c2082f6d964c8a62620153cc7e688d\", \"google_apis_unittests\": \"d78f21afa7f78e5a72bc775f0d9a6cfe4a36b88f\", \"gpu_unittests\": \"3557fd1bac21b75d5f0b0bdcf5ba77d956e2b766\", \"gwp_asan_unittests\": \"f26104bf6dd9cf24bc6606051e96ada1096a303b\", \"headless_browsertests\": \"48b5aaf63aedcf607a51a0e6bd659bf4a6055b1e\", \"headless_unittests\": \"78171ec170ffa04779d3ac0643f151a26c4e2d09\", \"interactive_ui_tests\": \"a5359e7faaba49ff2114f258cde2fc2e8da1a539\", \"ipc_tests\": \"488fd76b963dabca166d4fb24f68dd0457a1c51d\", \"jingle_unittests\": \"b2ae13e3dd70a53bd2fe048d09f998fcaf0941ca\", \"latency_unittests\": \"6e68c565f5a7c8d001cd442c7db0127548c0dd09\", \"libjingle_xmpp_unittests\": \"ff29fe73fe9235d40df4a11296b89ae6797edac4\", \"liburlpattern_unittests\": \"6bf9183cd55e4a694cdaf68a3c117558cd0fee18\", \"media_blink_unittests\": \"c80d5a8db01ba8af6c1e5c3b557227838f9f85db\", \"media_unittests\": \"2dfc40852686495b6cc771113fc11d333bc1f4f9\", \"message_center_unittests\": \"01e7a0952c4bb5e8666cb7286f2c3f7a6216e6b2\", \"midi_unittests\": \"26d4e43c33ea9aa4f3bfe0de98926477158d7fe5\", \"mojo_core_unittests\": \"92fe2e396a79f197ef37bc79e84fdf288cfa8b97\", \"mojo_unittests\": \"af03285b2b691db02037eedd26617b1da287c7dd\", \"nacl_helper_nonsfi_unittests\": \"54ef395a6489f28b8b214673e544129257ccfb74\", \"nacl_loader_unittests\": \"6377c8838cbef23ff8cb84744ba297b00433bd26\", \"native_theme_unittests\": \"eae07498436574dbac0f81f1f84d2076c8b1052b\", \"net_unittests\": \"23fd60391d09fcaeae9397d808754db2f16c46e1\", \"pdf_unittests\": \"c96aa0f7a3b1370d901af535f4fc6412578f7ff3\", \"perfetto_unittests\": \"1243c31dfedbe25be9801380a27819aee59184f1\", \"ppapi_unittests\": \"e8ad4bf67d6e063f55c9c590718bfcfadb339164\", \"printing_unittests\": \"966651d1da5d2baeee4ac0cadf3fe9dcb1a42852\", \"remoting_unittests\": \"da0d5404268153963a4fcb60a806b2cfcb057a2b\", \"sandbox_linux_unittests\": \"201e0e3dfac84a6c6a3ad2c88c37808f22820d26\", \"service_manager_unittests\": \"6074e6e97db223d1191cfb340ad69c1234d72e0f\", \"services_unittests\": \"c982b55dfc2cc359674324836d9df1a58728c88a\", \"shell_dialogs_unittests\": \"cfe084f53dd66248d55be7911cd5057da88ac0d8\", \"skia_unittests\": \"520556bf0d2ab0e75eb7117ae2f051d335f88cb0\", \"snapshot_unittests\": \"4fc1f6b0c5da9e00aae3bb7f2e61fdba811666dc\", \"sql_unittests\": \"5b9cfba153817a01ea871b65128c1e50f6200593\", \"storage_unittests\": \"ab2762acb69cbe8504201eac6913c46516adea6b\", \"sync_integration_tests\": \"fcc6551c994cb885f749e07108b5a5a740f9e3e4\", \"traffic_annotation_auditor_unittests\": \"ac5ea4cca89026a5ffa20792b4b0e3772f82e1b2\", \"ui_base_unittests\": \"4b66498d94c476a1f392a14af7083921d55f7da3\", \"ui_touch_selection_unittests\": \"ce63b4a14404041d1740dcc9f43556e8ba9a91ef\", \"unit_tests\": \"c8eec7921926081d11dd9f315a189a9cbc96771b\", \"url_unittests\": \"6d278853401e798763ad90178d3ec8f1e1a3f3d5\", \"views_unittests\": \"ad0d4ae105acb7f10feab3cdf48320657a1c4f7d\", \"viz_unittests\": \"836056297d4233d35d20c960a34855f133ecc2fd\", \"vr_common_unittests\": \"05492dca8ba6ab3c3d39fb7c5fc9d6cfc0f35802\", \"vr_pixeltests\": \"1a59ef24504d057c220b873dfca3cac83a94032f\", \"weblayer_browsertests\": \"33995633fb8ce72bcecdba3514ac583ac9f5ee93\", \"weblayer_unittests\": \"9b698f56ac8cf1650189f1a24e58cec86af65006\", \"wm_unittests\": \"44387cb6575ad82d2ce655db2b25be440fb90f92\", \"wtf_unittests\": \"5e179ea2f7f2405e63afe2f9a37cf2c768fc09c9\", \"x11_unittests\": \"19442a3e8994ab3240c2e233205ee2f4d86ae839\", \"xr_browser_tests\": \"99696b436ee72d7b3bfaf71ee66bd5936480de20\", \"zlib_unittests\": \"d83976a810d9c64d6bbe52bdaa775a02a095947f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_v2\", \"builder_db07e05d1559d315142a348713be48f60d2f52f0e9677b40d6bd49e99f5fa62e_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-14-t47x\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5725-1a0d85e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615130521522613",
"status": "COMPLETED",
"status_changed_ts": "1615140391523864",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/19875",
"builder:Linux CFI",
"buildset:commit/git/a6a96ac9553d3ebc86071c226a0c9e1ae17a0b5b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a6a96ac9553d3ebc86071c226a0c9e1ae17a0b5b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018836692328122320",
"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/8853406630299798688/+/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:52261941c6836410",
"user_agent:luci-scheduler"
],
"updated_ts": "1615140391751298",
"url": "https://ci.chromium.org/b/8853406630299798688",
"utcnow_ts": "1615140393321982"
}
}
[18:06:33.359] Invocation finished in 2h44m48.487072802s with status SUCCEEDED