[14:59:10.272] New invocation is queued and will start shortly
[14:59:11.367] Starting the invocation (attempt 1)
[14:59:11.401] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:59:11.402] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:59:11.402] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030887509279290848",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"66feb3c37aaa1dfef1691d73396f187a641db67f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9030887509279290848",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/66feb3c37aaa1dfef1691d73396f187a641db67f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/66feb3c37aaa1dfef1691d73396f187a641db67f",
"gitiles_ref:refs/heads/master"
]
}
[14:59:12.103] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603637951565819",
"id": "8865457447258446160",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"66feb3c37aaa1dfef1691d73396f187a641db67f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603637951919841",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/18764",
"builder:Linux CFI",
"buildset:commit/git/66feb3c37aaa1dfef1691d73396f187a641db67f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/66feb3c37aaa1dfef1691d73396f187a641db67f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030887509279290848",
"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/8865457447258446160/+/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": "1603637951919952",
"url": "https://ci.chromium.org/b/8865457447258446160",
"utcnow_ts": "1603637952097249"
}
}
[14:59:12.103] Task URL: https://ci.chromium.org/b/8865457447258446160
[14:59:12.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:2:0) after 1m0s
[14:59:16.318] Received PubSub notification, asking Buildbucket for the build status
[14:59:16.379] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:12.129] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:2:0)
[15:00:12.129] Timer tick, asking Buildbucket for the build status
[15:00:12.648] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:12.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:4:0) after 1m0s
[15:01:12.710] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:4:0)
[15:01:12.710] Timer tick, asking Buildbucket for the build status
[15:01:13.092] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:13.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:5:0) after 1m0s
[15:02:13.120] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:5:0)
[15:02:13.120] Timer tick, asking Buildbucket for the build status
[15:02:13.403] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:13.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:6:0) after 1m0s
[15:03:13.443] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:6:0)
[15:03:13.443] Timer tick, asking Buildbucket for the build status
[15:03:13.511] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:13.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:7:0) after 1m0s
[15:04:13.562] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:7:0)
[15:04:13.562] Timer tick, asking Buildbucket for the build status
[15:04:13.674] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:13.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:8:0) after 1m0s
[15:05:13.695] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:8:0)
[15:05:13.696] Timer tick, asking Buildbucket for the build status
[15:05:13.986] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:13.986] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:9:0) after 1m0s
[15:06:13.993] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:9:0)
[15:06:13.993] Timer tick, asking Buildbucket for the build status
[15:06:14.063] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:14.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:10:0) after 1m0s
[15:07:14.082] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:10:0)
[15:07:14.082] Timer tick, asking Buildbucket for the build status
[15:07:14.157] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:14.157] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:11:0) after 1m0s
[15:08:14.228] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:11:0)
[15:08:14.228] Timer tick, asking Buildbucket for the build status
[15:08:14.290] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:14.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:12:0) after 1m0s
[15:09:14.308] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:12:0)
[15:09:14.308] Timer tick, asking Buildbucket for the build status
[15:09:14.408] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:14.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:13:0) after 1m0s
[15:10:14.429] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:13:0)
[15:10:14.429] Timer tick, asking Buildbucket for the build status
[15:10:14.496] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:14.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:14:0) after 1m0s
[15:11:14.547] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:14:0)
[15:11:14.547] Timer tick, asking Buildbucket for the build status
[15:11:14.709] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:14.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:15:0) after 1m0s
[15:12:14.730] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:15:0)
[15:12:14.730] Timer tick, asking Buildbucket for the build status
[15:12:15.104] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:15.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:16:0) after 1m0s
[15:13:15.130] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:16:0)
[15:13:15.130] Timer tick, asking Buildbucket for the build status
[15:13:15.422] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:15.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:17:0) after 1m0s
[15:14:15.500] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:17:0)
[15:14:15.500] Timer tick, asking Buildbucket for the build status
[15:14:15.599] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:15.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:18:0) after 1m0s
[15:15:15.643] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:18:0)
[15:15:15.643] Timer tick, asking Buildbucket for the build status
[15:15:15.692] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:15.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:19:0) after 1m0s
[15:16:15.723] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:19:0)
[15:16:15.723] Timer tick, asking Buildbucket for the build status
[15:16:15.787] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:15.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:20:0) after 1m0s
[15:17:15.815] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:20:0)
[15:17:15.815] Timer tick, asking Buildbucket for the build status
[15:17:15.895] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:15.895] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:21:0) after 1m0s
[15:18:15.932] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:21:0)
[15:18:15.932] Timer tick, asking Buildbucket for the build status
[15:18:16.014] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:16.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:22:0) after 1m0s
[15:19:16.039] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:22:0)
[15:19:16.039] Timer tick, asking Buildbucket for the build status
[15:19:16.130] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:16.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:23:0) after 1m0s
[15:20:16.154] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:23:0)
[15:20:16.154] Timer tick, asking Buildbucket for the build status
[15:20:16.230] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:16.230] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:24:0) after 1m0s
[15:21:16.263] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:24:0)
[15:21:16.263] Timer tick, asking Buildbucket for the build status
[15:21:16.511] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:16.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:25:0) after 1m0s
[15:22:16.531] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:25:0)
[15:22:16.531] Timer tick, asking Buildbucket for the build status
[15:22:16.835] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:16.835] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:26:0) after 1m0s
[15:23:16.902] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:26:0)
[15:23:16.902] Timer tick, asking Buildbucket for the build status
[15:23:16.976] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:16.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:27:0) after 1m0s
[15:24:16.995] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:27:0)
[15:24:16.995] Timer tick, asking Buildbucket for the build status
[15:24:17.106] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:17.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:28:0) after 1m0s
[15:25:17.130] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:28:0)
[15:25:17.130] Timer tick, asking Buildbucket for the build status
[15:25:17.346] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:17.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:29:0) after 1m0s
[15:26:17.367] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:29:0)
[15:26:17.367] Timer tick, asking Buildbucket for the build status
[15:26:17.497] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:17.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:30:0) after 1m0s
[15:27:17.518] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:30:0)
[15:27:17.518] Timer tick, asking Buildbucket for the build status
[15:27:17.867] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:17.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:31:0) after 1m0s
[15:28:17.887] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:31:0)
[15:28:17.887] Timer tick, asking Buildbucket for the build status
[15:28:17.947] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:17.947] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:32:0) after 1m0s
[15:29:17.980] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:32:0)
[15:29:17.980] Timer tick, asking Buildbucket for the build status
[15:29:18.093] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:18.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:33:0) after 1m0s
[15:30:18.170] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:33:0)
[15:30:18.170] Timer tick, asking Buildbucket for the build status
[15:30:18.268] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:18.268] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:34:0) after 1m0s
[15:31:18.293] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:34:0)
[15:31:18.293] Timer tick, asking Buildbucket for the build status
[15:31:18.356] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:18.356] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:35:0) after 1m0s
[15:32:18.389] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:35:0)
[15:32:18.389] Timer tick, asking Buildbucket for the build status
[15:32:18.535] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:18.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:36:0) after 1m0s
[15:33:18.563] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:36:0)
[15:33:18.563] Timer tick, asking Buildbucket for the build status
[15:33:18.837] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:18.837] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:37:0) after 1m0s
[15:34:18.859] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:37:0)
[15:34:18.859] Timer tick, asking Buildbucket for the build status
[15:34:18.971] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:18.971] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:38:0) after 1m0s
[15:35:18.994] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:38:0)
[15:35:18.994] Timer tick, asking Buildbucket for the build status
[15:35:19.073] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:19.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:39:0) after 1m0s
[15:36:19.127] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:39:0)
[15:36:19.127] Timer tick, asking Buildbucket for the build status
[15:36:19.205] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:19.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:40:0) after 1m0s
[15:37:19.312] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:40:0)
[15:37:19.312] Timer tick, asking Buildbucket for the build status
[15:37:19.368] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:19.369] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:41:0) after 1m0s
[15:38:19.450] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:41:0)
[15:38:19.450] Timer tick, asking Buildbucket for the build status
[15:38:19.520] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:19.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:42:0) after 1m0s
[15:39:19.590] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:42:0)
[15:39:19.590] Timer tick, asking Buildbucket for the build status
[15:39:19.717] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:19.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:43:0) after 1m0s
[15:40:19.741] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:43:0)
[15:40:19.741] Timer tick, asking Buildbucket for the build status
[15:40:19.808] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:19.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:44:0) after 1m0s
[15:41:19.798] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:44:0)
[15:41:19.798] Timer tick, asking Buildbucket for the build status
[15:41:19.870] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:19.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:45:0) after 1m0s
[15:42:20.116] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:45:0)
[15:42:20.116] Timer tick, asking Buildbucket for the build status
[15:42:20.187] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:20.188] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:46:0) after 1m0s
[15:43:20.243] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:46:0)
[15:43:20.243] Timer tick, asking Buildbucket for the build status
[15:43:20.633] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:20.633] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:47:0) after 1m0s
[15:44:20.709] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:47:0)
[15:44:20.709] Timer tick, asking Buildbucket for the build status
[15:44:20.816] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:20.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:48:0) after 1m0s
[15:45:20.875] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:48:0)
[15:45:20.875] Timer tick, asking Buildbucket for the build status
[15:45:20.933] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:20.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:49:0) after 1m0s
[15:46:21.008] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:49:0)
[15:46:21.009] Timer tick, asking Buildbucket for the build status
[15:46:21.060] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:21.060] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:50:0) after 1m0s
[15:47:21.210] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:50:0)
[15:47:21.210] Timer tick, asking Buildbucket for the build status
[15:47:21.409] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:21.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:51:0) after 1m0s
[15:48:21.400] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:51:0)
[15:48:21.400] Timer tick, asking Buildbucket for the build status
[15:48:21.504] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:21.504] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:52:0) after 1m0s
[15:49:21.530] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:52:0)
[15:49:21.530] Timer tick, asking Buildbucket for the build status
[15:49:21.899] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:21.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:53:0) after 1m0s
[15:50:22.022] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:53:0)
[15:50:22.022] Timer tick, asking Buildbucket for the build status
[15:50:22.159] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:22.159] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:54:0) after 1m0s
[15:51:22.236] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:54:0)
[15:51:22.236] Timer tick, asking Buildbucket for the build status
[15:51:22.333] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:22.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:55:0) after 1m0s
[15:52:22.388] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:55:0)
[15:52:22.388] Timer tick, asking Buildbucket for the build status
[15:52:22.454] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:22.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:56:0) after 1m0s
[15:53:22.579] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:56:0)
[15:53:22.579] Timer tick, asking Buildbucket for the build status
[15:53:22.660] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:22.660] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:57:0) after 1m0s
[15:54:22.990] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:57:0)
[15:54:22.990] Timer tick, asking Buildbucket for the build status
[15:54:23.123] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:23.123] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:58:0) after 1m0s
[15:55:23.127] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:58:0)
[15:55:23.127] Timer tick, asking Buildbucket for the build status
[15:55:23.197] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:23.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:59:0) after 1m0s
[15:56:23.729] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:59:0)
[15:56:23.729] Timer tick, asking Buildbucket for the build status
[15:56:23.793] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:23.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:60:0) after 1m0s
[15:57:23.824] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:60:0)
[15:57:23.824] Timer tick, asking Buildbucket for the build status
[15:57:23.919] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:23.919] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:61:0) after 1m0s
[15:58:24.019] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:61:0)
[15:58:24.019] Timer tick, asking Buildbucket for the build status
[15:58:24.074] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:24.074] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:62:0) after 1m0s
[15:59:24.303] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:62:0)
[15:59:24.303] Timer tick, asking Buildbucket for the build status
[15:59:24.516] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:24.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:63:0) after 1m0s
[16:00:24.643] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:63:0)
[16:00:24.643] Timer tick, asking Buildbucket for the build status
[16:00:24.741] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:24.741] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:64:0) after 1m0s
[16:01:24.999] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:64:0)
[16:01:24.999] Timer tick, asking Buildbucket for the build status
[16:01:25.056] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:25.056] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:65:0) after 1m0s
[16:02:25.422] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:65:0)
[16:02:25.422] Timer tick, asking Buildbucket for the build status
[16:02:25.614] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:25.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:66:0) after 1m0s
[16:03:25.890] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:66:0)
[16:03:25.890] Timer tick, asking Buildbucket for the build status
[16:03:25.966] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:25.966] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:67:0) after 1m0s
[16:04:26.178] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:67:0)
[16:04:26.178] Timer tick, asking Buildbucket for the build status
[16:04:26.368] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:26.368] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:68:0) after 1m0s
[16:05:26.471] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:68:0)
[16:05:26.471] Timer tick, asking Buildbucket for the build status
[16:05:26.969] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:26.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:69:0) after 1m0s
[16:06:27.182] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:69:0)
[16:06:27.182] Timer tick, asking Buildbucket for the build status
[16:06:27.246] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:27.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:70:0) after 1m0s
[16:07:27.596] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:70:0)
[16:07:27.596] Timer tick, asking Buildbucket for the build status
[16:07:27.676] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:27.676] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:71:0) after 1m0s
[16:08:27.848] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:71:0)
[16:08:27.848] Timer tick, asking Buildbucket for the build status
[16:08:28.105] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:28.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:72:0) after 1m0s
[16:09:28.111] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:72:0)
[16:09:28.111] Timer tick, asking Buildbucket for the build status
[16:09:28.237] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:28.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:73:0) after 1m0s
[16:10:28.286] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:73:0)
[16:10:28.286] Timer tick, asking Buildbucket for the build status
[16:10:28.341] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:28.341] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:74:0) after 1m0s
[16:11:28.418] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:74:0)
[16:11:28.418] Timer tick, asking Buildbucket for the build status
[16:11:28.475] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:28.475] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:75:0) after 1m0s
[16:12:28.499] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:75:0)
[16:12:28.499] Timer tick, asking Buildbucket for the build status
[16:12:28.800] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:28.800] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:76:0) after 1m0s
[16:13:28.816] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:76:0)
[16:13:28.816] Timer tick, asking Buildbucket for the build status
[16:13:28.872] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:28.872] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:77:0) after 1m0s
[16:14:29.087] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:77:0)
[16:14:29.087] Timer tick, asking Buildbucket for the build status
[16:14:29.253] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:29.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:78:0) after 1m0s
[16:15:29.328] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:78:0)
[16:15:29.328] Timer tick, asking Buildbucket for the build status
[16:15:29.387] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:29.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:79:0) after 1m0s
[16:16:29.457] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:79:0)
[16:16:29.457] Timer tick, asking Buildbucket for the build status
[16:16:29.540] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:29.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:80:0) after 1m0s
[16:17:29.787] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:80:0)
[16:17:29.787] Timer tick, asking Buildbucket for the build status
[16:17:30.100] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:30.100] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:81:0) after 1m0s
[16:18:30.228] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:81:0)
[16:18:30.228] Timer tick, asking Buildbucket for the build status
[16:18:30.304] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:30.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:82:0) after 1m0s
[16:19:30.405] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:82:0)
[16:19:30.405] Timer tick, asking Buildbucket for the build status
[16:19:30.502] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:30.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:83:0) after 1m0s
[16:20:30.597] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:83:0)
[16:20:30.597] Timer tick, asking Buildbucket for the build status
[16:20:30.804] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:30.804] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:84:0) after 1m0s
[16:21:30.830] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:84:0)
[16:21:30.830] Timer tick, asking Buildbucket for the build status
[16:21:30.923] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:30.923] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:85:0) after 1m0s
[16:22:30.993] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:85:0)
[16:22:30.993] Timer tick, asking Buildbucket for the build status
[16:22:31.066] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:31.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:86:0) after 1m0s
[16:23:31.126] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:86:0)
[16:23:31.126] Timer tick, asking Buildbucket for the build status
[16:23:31.335] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:31.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:87:0) after 1m0s
[16:24:31.364] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:87:0)
[16:24:31.364] Timer tick, asking Buildbucket for the build status
[16:24:31.737] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:31.737] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:88:0) after 1m0s
[16:25:31.725] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:88:0)
[16:25:31.725] Timer tick, asking Buildbucket for the build status
[16:25:31.909] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:31.909] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:89:0) after 1m0s
[16:26:31.933] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:89:0)
[16:26:31.933] Timer tick, asking Buildbucket for the build status
[16:26:31.996] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:31.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:90:0) after 1m0s
[16:27:32.030] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:90:0)
[16:27:32.030] Timer tick, asking Buildbucket for the build status
[16:27:32.432] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:32.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:91:0) after 1m0s
[16:28:32.455] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:91:0)
[16:28:32.455] Timer tick, asking Buildbucket for the build status
[16:28:32.519] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:32.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:92:0) after 1m0s
[16:29:32.550] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:92:0)
[16:29:32.550] Timer tick, asking Buildbucket for the build status
[16:29:32.654] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:32.654] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:93:0) after 1m0s
[16:30:32.706] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:93:0)
[16:30:32.706] Timer tick, asking Buildbucket for the build status
[16:30:32.808] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:32.808] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:94:0) after 1m0s
[16:31:32.861] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:94:0)
[16:31:32.861] Timer tick, asking Buildbucket for the build status
[16:31:33.007] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:33.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:95:0) after 1m0s
[16:32:33.133] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:95:0)
[16:32:33.133] Timer tick, asking Buildbucket for the build status
[16:32:33.210] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:33.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:96:0) after 1m0s
[16:33:33.266] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:96:0)
[16:33:33.266] Timer tick, asking Buildbucket for the build status
[16:33:33.379] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:33.379] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:97:0) after 1m0s
[16:34:33.401] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:97:0)
[16:34:33.401] Timer tick, asking Buildbucket for the build status
[16:34:33.499] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:33.499] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:98:0) after 1m0s
[16:35:33.554] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:98:0)
[16:35:33.554] Timer tick, asking Buildbucket for the build status
[16:35:33.747] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:33.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:99:0) after 1m0s
[16:36:33.791] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:99:0)
[16:36:33.791] Timer tick, asking Buildbucket for the build status
[16:36:33.954] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:33.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:100:0) after 1m0s
[16:37:33.987] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:100:0)
[16:37:33.987] Timer tick, asking Buildbucket for the build status
[16:37:34.220] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:34.220] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:101:0) after 1m0s
[16:38:34.320] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:101:0)
[16:38:34.321] Timer tick, asking Buildbucket for the build status
[16:38:34.898] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:34.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:102:0) after 1m0s
[16:39:34.974] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:102:0)
[16:39:34.974] Timer tick, asking Buildbucket for the build status
[16:39:35.316] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:35.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:103:0) after 1m0s
[16:40:35.337] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:103:0)
[16:40:35.337] Timer tick, asking Buildbucket for the build status
[16:40:35.427] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:35.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:104:0) after 1m0s
[16:41:35.454] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:104:0)
[16:41:35.454] Timer tick, asking Buildbucket for the build status
[16:41:35.990] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:35.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:105:0) after 1m0s
[16:42:36.067] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:105:0)
[16:42:36.067] Timer tick, asking Buildbucket for the build status
[16:42:37.427] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:37.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:106:0) after 1m0s
[16:43:37.495] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:106:0)
[16:43:37.495] Timer tick, asking Buildbucket for the build status
[16:43:37.599] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:37.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:107:0) after 1m0s
[16:44:37.679] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:107:0)
[16:44:37.679] Timer tick, asking Buildbucket for the build status
[16:44:37.781] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:37.781] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:108:0) after 1m0s
[16:45:37.828] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:108:0)
[16:45:37.828] Timer tick, asking Buildbucket for the build status
[16:45:37.899] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:37.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:109:0) after 1m0s
[16:46:37.996] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:109:0)
[16:46:37.996] Timer tick, asking Buildbucket for the build status
[16:46:38.067] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:38.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:110:0) after 1m0s
[16:47:38.162] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:110:0)
[16:47:38.162] Timer tick, asking Buildbucket for the build status
[16:47:38.288] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:38.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:111:0) after 1m0s
[16:48:38.365] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:111:0)
[16:48:38.365] Timer tick, asking Buildbucket for the build status
[16:48:38.472] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:38.472] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:112:0) after 1m0s
[16:49:38.567] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:112:0)
[16:49:38.567] Timer tick, asking Buildbucket for the build status
[16:49:38.685] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:38.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:113:0) after 1m0s
[16:50:38.722] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:113:0)
[16:50:38.722] Timer tick, asking Buildbucket for the build status
[16:50:38.938] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:38.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:114:0) after 1m0s
[16:51:39.003] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:114:0)
[16:51:39.003] Timer tick, asking Buildbucket for the build status
[16:51:40.104] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:40.104] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:115:0) after 1m0s
[16:52:40.121] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:115:0)
[16:52:40.121] Timer tick, asking Buildbucket for the build status
[16:52:40.193] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:40.194] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:116:0) after 1m0s
[16:53:40.195] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:116:0)
[16:53:40.195] Timer tick, asking Buildbucket for the build status
[16:53:40.265] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:40.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:117:0) after 1m0s
[16:54:40.297] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:117:0)
[16:54:40.297] Timer tick, asking Buildbucket for the build status
[16:54:40.685] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:40.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:118:0) after 1m0s
[16:55:40.725] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:118:0)
[16:55:40.725] Timer tick, asking Buildbucket for the build status
[16:55:41.005] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:41.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:119:0) after 1m0s
[16:56:41.020] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:119:0)
[16:56:41.020] Timer tick, asking Buildbucket for the build status
[16:56:41.105] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:41.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:120:0) after 1m0s
[16:57:41.129] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:120:0)
[16:57:41.129] Timer tick, asking Buildbucket for the build status
[16:57:41.207] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:41.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:121:0) after 1m0s
[16:58:41.235] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:121:0)
[16:58:41.235] Timer tick, asking Buildbucket for the build status
[16:58:41.300] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:41.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:122:0) after 1m0s
[16:59:41.343] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:122:0)
[16:59:41.343] Timer tick, asking Buildbucket for the build status
[16:59:41.450] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:41.450] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:123:0) after 1m0s
[17:00:41.481] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:123:0)
[17:00:41.481] Timer tick, asking Buildbucket for the build status
[17:00:41.561] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:41.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:124:0) after 1m0s
[17:01:41.620] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:124:0)
[17:01:41.620] Timer tick, asking Buildbucket for the build status
[17:01:41.949] Build 8865457447258446160: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:41.949] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030887509279290848:125:0) after 1m0s
[17:01:47.526] Received PubSub notification, asking Buildbucket for the build status
[17:01:47.781] Build 8865457447258446160: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:01:47.781] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603645305337690",
"created_by": "project:chromium",
"created_ts": "1603637951565819",
"id": "8865457447258446160",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"66feb3c37aaa1dfef1691d73396f187a641db67f\"}}",
"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\": \"66feb3c37aaa1dfef1691d73396f187a641db67f\", \"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\": 18764, \"got_angle_revision\": \"7a0263547cda936b320d80c650b69d7522ee1a9f\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"66feb3c37aaa1dfef1691d73396f187a641db67f\", \"got_revision_cp\": \"refs/heads/master@{#820617}\", \"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\": \"e6fa238f76e50a8caa0547074f75443bbfd7b986\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32482}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"66feb3c37aaa1dfef1691d73396f187a641db67f\", \"swarm_hashes_refs/heads/master(at){#820617}_without_patch\": {\"absl_hardening_tests\": \"64f62512e9f03cbf530bff5711b084547b2ef664\", \"accessibility_unittests\": \"3739945aa5d8bcfcbd0b29739c55080409f2ce3f\", \"angle_unittests\": \"a1749d9f60c0db4381604a60b18caf14ec8ac235\", \"app_shell_unittests\": \"31be3dcd7e75f3bd737037ed3b2c14c3e4db82cb\", \"aura_unittests\": \"253cadcd2c59e8111ce703f2abacc01a9365bf23\", \"base_unittests\": \"6c4ed79285daf6081f34b2f9bb7e635e41abf453\", \"base_util_unittests\": \"bd7ba5f422993e3378e5f50327aef1d8f9db4923\", \"blink_common_unittests\": \"e3097465c45ca3d32b7a112b93b041b34b9846d8\", \"blink_fuzzer_unittests\": \"d57eb4db31814d594bf90d1e9fd51d10d0c6196e\", \"blink_heap_unittests\": \"858256cca36a20e79604c738e6b2dc863134fd8b\", \"blink_platform_unittests\": \"4530df48133fb8f419f956e1ba13d2c0bf386030\", \"blink_unittests\": \"a405173f70ef282180d8ae8eefdfe3c2fac57108\", \"boringssl_crypto_tests\": \"e149e781e9928a29b4dd9583f17cfba686900c7b\", \"boringssl_ssl_tests\": \"67e991e557e4bcf147544aa74198c7c6c19a1c54\", \"browser_tests\": \"7880ff5634de3753141f50d8cc4aa78618213194\", \"capture_unittests\": \"fa4ac5d79c1400e172191442130c361328df14ac\", \"cast_unittests\": \"ae27d0c76df19edfe7c7621686230f7cee08b67e\", \"cc_unittests\": \"5dc0cd6943f6b8886fce267b95a7579bb902c5ac\", \"chrome_app_unittests\": \"b4f7075070e1115b15b0914644b7ea957d1197d9\", \"chromedriver_unittests\": \"473a2b7c5f1e1af2be4ffa4e13b6f8910d4deddf\", \"components_browsertests\": \"253e270ee3a0f3e3373dc64cfd398eca409f5b85\", \"components_unittests\": \"14a65aafb8bdbd68951086f460941ee8cde98268\", \"compositor_unittests\": \"613f679dcdd7726b6cb3b816691a0894a335dd71\", \"content_browsertests\": \"854d6098c92d438be96d765fadf250ce516e6044\", \"content_unittests\": \"2c21aa7d3a4274399225a691d74805b123dc92b1\", \"cronet_tests\": \"8a6906d066bac73fdc0cab61beee5c142ccd5d27\", \"cronet_unittests\": \"6aaef5946e0b40575c7349514f6781966a6d7b2d\", \"crypto_unittests\": \"1fa4a8923d25457a5b0e23a99d4d2bede6a7ceba\", \"dbus_unittests\": \"0182c7b13835f4cce4225d6092d3350a1308b816\", \"device_unittests\": \"3bec8d43475965b7e1bf68fb4410ce35c333e28b\", \"display_unittests\": \"b083b1ea9576796a2858c957c0909fb1146e195e\", \"events_unittests\": \"8ef9b84a71101b4167b482a24d690dfdc2136133\", \"extensions_browsertests\": \"06a845a267e336cca9788179eb6fcc5d33470c1d\", \"extensions_unittests\": \"53c77fd6b6eab456c108efab23e8f094746af224\", \"filesystem_service_unittests\": \"2bb333643bcb36a135fd6714b5f327ee11cc718d\", \"gcm_unit_tests\": \"7307effccef0d30f1cb4a52b77a464a4d6a2acbb\", \"gfx_unittests\": \"9d2925415d170443fa8fde393a3da6a3ba15b8d5\", \"gin_unittests\": \"bd528d53cfacc7a2bbf1957bc96d1be081594092\", \"gl_tests\": \"ec6045f4fd0b962951ab8ce28b496abf6fd4be14\", \"gl_unittests\": \"9a9a3003e7929cc05dbd4d3e38ee2b5c1b88a43c\", \"google_apis_unittests\": \"d2c7c8271e96e2624cadce9a0545cffb9eff560c\", \"gpu_unittests\": \"4a23d26b2a0b3ad57cbedec28708101c02e7178a\", \"gwp_asan_unittests\": \"9b4c1237e71d0d3384f222e9fd8250de35a3b406\", \"headless_browsertests\": \"25cf2f13177b86ec935bedef3ff5210de1c0c4a2\", \"headless_unittests\": \"c664f6b613da99e853cddfb6e1f8874af5171286\", \"interactive_ui_tests\": \"fc422d6fb1962209e3ee64d9ca8033a289cf0b0c\", \"ipc_tests\": \"a4d94a368215d9d345e814b042dcce7ac33f25ed\", \"jingle_unittests\": \"3140f400d2c1a870a3d812f629f67900d7500f63\", \"latency_unittests\": \"b9c1ec9b7ccc127eeb829a92f18bb8f9ef27990c\", \"libjingle_xmpp_unittests\": \"04bc62d64e01dd731326a93760cec313311785d2\", \"media_blink_unittests\": \"21e06a1d54699e560977ee36cf900577bab6905e\", \"media_unittests\": \"4e8f3483aefee04c876e56c545fc59ccf268abe3\", \"message_center_unittests\": \"5152c2eea2469412acb1ae7ee917329b2e0fd6b1\", \"midi_unittests\": \"0abd54edda4ebf01018e9d9c5bc061b2ad985c84\", \"mojo_core_unittests\": \"f11ade16466cc34749b7a32dbc3aca860f9a8d20\", \"mojo_unittests\": \"39af4c06160e05b9f764f997273b9cc269779dde\", \"nacl_helper_nonsfi_unittests\": \"2ee71dae2e47ae9d8a7e39a784c5186400d7319d\", \"nacl_loader_unittests\": \"31d6f68d713bf17be6527c805f2f8bc2c07877cf\", \"native_theme_unittests\": \"054ee7039471ff4c8835f8ad9704397c9d2a297a\", \"net_unittests\": \"653cbf6086987250af9d460b52c012a3d8f74cee\", \"pdf_unittests\": \"f3500f88e6bb5c50053ea4ddd7c632f752e0d1ed\", \"perfetto_unittests\": \"f52f5e9c31bddf461a7f0a9cc7119b1210c495d0\", \"ppapi_unittests\": \"2c5a29d3071f25ddc2985d9e72d769e74cef803a\", \"printing_unittests\": \"bb674dd07ad20f936fda8ac49aa1208002fca6a3\", \"remoting_unittests\": \"aed29d84300ebb317bc71165bc5d7985fded2c20\", \"sandbox_linux_unittests\": \"7a9d081b42297dcd6d9879ba15d2147670786d1a\", \"service_manager_unittests\": \"ed6710718d1533a35d0d33ffb196c22619004ac8\", \"services_unittests\": \"cd2f02a6293f0d7cdf8301bace0ef3ff397ef431\", \"shell_dialogs_unittests\": \"e4bff8ce0fb6fc46da259adad2bbdee2914f6fe4\", \"skia_unittests\": \"ca5c1aea2304b33ea083b8bf3f9eb9c73ba02bd5\", \"snapshot_unittests\": \"2fd7012b6ee1156c33c6d33a35c8c8d34f67a310\", \"sql_unittests\": \"6824602b65e1d34bad5d7b33da6d089fb19ad4af\", \"storage_unittests\": \"f874edb50690193e000388e9bc97b52cdefa793d\", \"sync_integration_tests\": \"edef69c8bcccbb76db6bf99ba23c93e3ff72a5ed\", \"traffic_annotation_auditor_unittests\": \"955e2c3d311b7a44b732e8f58efc6c360097ab94\", \"ui_base_unittests\": \"84f91b4639b051ee7fd75b52304588ecf1e87ab2\", \"ui_touch_selection_unittests\": \"1b7e23a66aa7008855db2c464e6d7e37e809b9d1\", \"unit_tests\": \"6b04f4d8140b04f750a18a5dc21d9107356106e8\", \"url_unittests\": \"f939f523c4c4deb05921789ac76b9aaf5d747b47\", \"views_unittests\": \"67b57d9c775d35e4037479b45a492d1507e10386\", \"viz_unittests\": \"82d2225b93f685b9c66968296082f28dc1cfbdac\", \"vr_common_unittests\": \"aa371c4990ddc77989fcbb7e719b8b5b6e497d7e\", \"vr_pixeltests\": \"3d257494de1ad177db5a1ca8a3ddf80d9685f077\", \"wm_unittests\": \"52d1f7a9eb7746deb128f3f5bc5ff5fd5e042033\", \"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": "1603637955704963",
"status": "COMPLETED",
"status_changed_ts": "1603645305878965",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/18764",
"builder:Linux CFI",
"buildset:commit/git/66feb3c37aaa1dfef1691d73396f187a641db67f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/66feb3c37aaa1dfef1691d73396f187a641db67f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030887509279290848",
"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/8865457447258446160/+/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:4f7916c8231bb310",
"user_agent:luci-scheduler"
],
"updated_ts": "1603645305883073",
"url": "https://ci.chromium.org/b/8865457447258446160",
"utcnow_ts": "1603645307714726"
}
}
[17:01:47.781] Invocation finished in 2h2m37.527431799s with status SUCCEEDED