[02:25:22.621] New invocation is queued and will start shortly
[02:25:23.859] Starting the invocation (attempt 1)
[02:25:23.906] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:25:23.906] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:25:23.906] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9047423581791830160",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"53f63f71832350e18f342e001a9f3077eb8f723b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9047423581791830160",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/53f63f71832350e18f342e001a9f3077eb8f723b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53f63f71832350e18f342e001a9f3077eb8f723b",
"gitiles_ref:refs/heads/master"
]
}
[02:25:24.599] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1587867924006310",
"id": "8881993519675396208",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53f63f71832350e18f342e001a9f3077eb8f723b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1587867924474604",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/17017",
"builder:Linux CFI",
"buildset:commit/git/53f63f71832350e18f342e001a9f3077eb8f723b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53f63f71832350e18f342e001a9f3077eb8f723b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9047423581791830160",
"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/8881993519675396208/+/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": "1587867924474727",
"url": "https://ci.chromium.org/b/8881993519675396208",
"utcnow_ts": "1587867924591800"
}
}
[02:25:24.599] Task URL: https://ci.chromium.org/b/8881993519675396208
[02:25:24.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:2:0) after 1m0s
[02:26:24.635] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:2:0)
[02:26:24.635] Timer tick, asking Buildbucket for the build status
[02:26:24.765] Build 8881993519675396208: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:24.765] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:3:0) after 1m0s
[02:27:24.843] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:3:0)
[02:27:24.843] Timer tick, asking Buildbucket for the build status
[02:27:24.940] Build 8881993519675396208: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:24.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:4:0) after 1m0s
[02:28:14.328] Received PubSub notification, asking Buildbucket for the build status
[02:28:14.482] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:24.961] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:4:0)
[02:28:24.961] Timer tick, asking Buildbucket for the build status
[02:28:25.050] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:25.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:6:0) after 1m0s
[02:29:25.115] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:6:0)
[02:29:25.115] Timer tick, asking Buildbucket for the build status
[02:29:25.245] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:25.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:7:0) after 1m0s
[02:30:25.386] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:7:0)
[02:30:25.386] Timer tick, asking Buildbucket for the build status
[02:30:25.496] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:25.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:8:0) after 1m0s
[02:31:25.563] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:8:0)
[02:31:25.563] Timer tick, asking Buildbucket for the build status
[02:31:25.691] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:25.691] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:9:0) after 1m0s
[02:32:25.717] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:9:0)
[02:32:25.717] Timer tick, asking Buildbucket for the build status
[02:32:26.059] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:26.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:10:0) after 1m0s
[02:33:26.085] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:10:0)
[02:33:26.085] Timer tick, asking Buildbucket for the build status
[02:33:26.550] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:26.550] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:11:0) after 1m0s
[02:34:26.576] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:11:0)
[02:34:26.576] Timer tick, asking Buildbucket for the build status
[02:34:26.730] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:26.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:12:0) after 1m0s
[02:35:26.759] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:12:0)
[02:35:26.759] Timer tick, asking Buildbucket for the build status
[02:35:27.076] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:27.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:13:0) after 1m0s
[02:36:27.148] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:13:0)
[02:36:27.148] Timer tick, asking Buildbucket for the build status
[02:36:27.283] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:27.283] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:14:0) after 1m0s
[02:37:27.301] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:14:0)
[02:37:27.301] Timer tick, asking Buildbucket for the build status
[02:37:27.401] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:27.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:15:0) after 1m0s
[02:38:27.441] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:15:0)
[02:38:27.441] Timer tick, asking Buildbucket for the build status
[02:38:27.749] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:27.749] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:16:0) after 1m0s
[02:39:27.809] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:16:0)
[02:39:27.809] Timer tick, asking Buildbucket for the build status
[02:39:27.945] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:27.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:17:0) after 1m0s
[02:40:28.067] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:17:0)
[02:40:28.067] Timer tick, asking Buildbucket for the build status
[02:40:28.469] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:28.469] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:18:0) after 1m0s
[02:41:28.501] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:18:0)
[02:41:28.502] Timer tick, asking Buildbucket for the build status
[02:41:28.627] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:28.627] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:19:0) after 1m0s
[02:42:28.629] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:19:0)
[02:42:28.629] Timer tick, asking Buildbucket for the build status
[02:42:28.743] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:28.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:20:0) after 1m0s
[02:43:28.820] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:20:0)
[02:43:28.820] Timer tick, asking Buildbucket for the build status
[02:43:28.963] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:28.963] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:21:0) after 1m0s
[02:44:29.085] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:21:0)
[02:44:29.085] Timer tick, asking Buildbucket for the build status
[02:44:29.176] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:29.176] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:22:0) after 1m0s
[02:45:29.403] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:22:0)
[02:45:29.403] Timer tick, asking Buildbucket for the build status
[02:45:29.530] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:29.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:23:0) after 1m0s
[02:46:29.605] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:23:0)
[02:46:29.605] Timer tick, asking Buildbucket for the build status
[02:46:29.712] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:29.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:24:0) after 1m0s
[02:47:29.724] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:24:0)
[02:47:29.724] Timer tick, asking Buildbucket for the build status
[02:47:30.635] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:30.635] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:25:0) after 1m0s
[02:48:30.725] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:25:0)
[02:48:30.725] Timer tick, asking Buildbucket for the build status
[02:48:30.970] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:30.970] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:26:0) after 1m0s
[02:49:31.056] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:26:0)
[02:49:31.056] Timer tick, asking Buildbucket for the build status
[02:49:31.153] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:31.153] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:27:0) after 1m0s
[02:50:32.156] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:27:0)
[02:50:32.156] Timer tick, asking Buildbucket for the build status
[02:50:32.269] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:32.269] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:28:0) after 1m0s
[02:51:32.563] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:28:0)
[02:51:32.563] Timer tick, asking Buildbucket for the build status
[02:51:32.662] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:32.662] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:29:0) after 1m0s
[02:52:32.786] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:29:0)
[02:52:32.786] Timer tick, asking Buildbucket for the build status
[02:52:32.973] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:32.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:30:0) after 1m0s
[02:53:33.148] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:30:0)
[02:53:33.148] Timer tick, asking Buildbucket for the build status
[02:53:33.367] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:33.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:31:0) after 1m0s
[02:54:33.438] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:31:0)
[02:54:33.438] Timer tick, asking Buildbucket for the build status
[02:54:33.526] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:33.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:32:0) after 1m0s
[02:55:33.829] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:32:0)
[02:55:33.830] Timer tick, asking Buildbucket for the build status
[02:55:33.954] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:33.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:33:0) after 1m0s
[02:56:36.084] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:33:0)
[02:56:36.084] Timer tick, asking Buildbucket for the build status
[02:56:36.605] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:36.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:34:0) after 1m0s
[02:57:36.633] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:34:0)
[02:57:36.633] Timer tick, asking Buildbucket for the build status
[02:57:36.776] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:36.776] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:35:0) after 1m0s
[02:58:36.803] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:35:0)
[02:58:36.803] Timer tick, asking Buildbucket for the build status
[02:58:36.935] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:36.935] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:36:0) after 1m0s
[02:59:37.400] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:36:0)
[02:59:37.400] Timer tick, asking Buildbucket for the build status
[02:59:37.480] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:37.480] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:37:0) after 1m0s
[03:00:37.677] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:37:0)
[03:00:37.677] Timer tick, asking Buildbucket for the build status
[03:00:37.854] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:37.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:38:0) after 1m0s
[03:01:37.959] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:38:0)
[03:01:37.959] Timer tick, asking Buildbucket for the build status
[03:01:38.093] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:38.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:39:0) after 1m0s
[03:02:38.447] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:39:0)
[03:02:38.447] Timer tick, asking Buildbucket for the build status
[03:02:38.938] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:38.938] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:40:0) after 1m0s
[03:03:39.250] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:40:0)
[03:03:39.250] Timer tick, asking Buildbucket for the build status
[03:03:39.408] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:39.408] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:41:0) after 1m0s
[03:04:39.470] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:41:0)
[03:04:39.470] Timer tick, asking Buildbucket for the build status
[03:04:39.751] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:39.751] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:42:0) after 1m0s
[03:05:40.558] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:42:0)
[03:05:40.558] Timer tick, asking Buildbucket for the build status
[03:05:40.705] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:40.705] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:43:0) after 1m0s
[03:06:40.738] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:43:0)
[03:06:40.738] Timer tick, asking Buildbucket for the build status
[03:06:40.875] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:40.875] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:44:0) after 1m0s
[03:07:40.921] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:44:0)
[03:07:40.921] Timer tick, asking Buildbucket for the build status
[03:07:42.288] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:42.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:45:0) after 1m0s
[03:08:42.388] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:45:0)
[03:08:42.388] Timer tick, asking Buildbucket for the build status
[03:08:42.506] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:42.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:46:0) after 1m0s
[03:09:42.531] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:46:0)
[03:09:42.531] Timer tick, asking Buildbucket for the build status
[03:09:42.622] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:42.622] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:47:0) after 1m0s
[03:10:42.608] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:47:0)
[03:10:42.608] Timer tick, asking Buildbucket for the build status
[03:10:42.730] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:42.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:48:0) after 1m0s
[03:11:42.788] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:48:0)
[03:11:42.788] Timer tick, asking Buildbucket for the build status
[03:11:42.904] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:42.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:49:0) after 1m0s
[03:12:42.929] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:49:0)
[03:12:42.929] Timer tick, asking Buildbucket for the build status
[03:12:43.064] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:43.064] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:50:0) after 1m0s
[03:13:43.154] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:50:0)
[03:13:43.154] Timer tick, asking Buildbucket for the build status
[03:13:43.277] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:43.277] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:51:0) after 1m0s
[03:14:43.329] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:51:0)
[03:14:43.329] Timer tick, asking Buildbucket for the build status
[03:14:43.420] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:43.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:52:0) after 1m0s
[03:15:43.506] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:52:0)
[03:15:43.506] Timer tick, asking Buildbucket for the build status
[03:15:43.882] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:43.882] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:53:0) after 1m0s
[03:16:43.979] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:53:0)
[03:16:43.979] Timer tick, asking Buildbucket for the build status
[03:16:44.168] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:44.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:54:0) after 1m0s
[03:17:44.274] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:54:0)
[03:17:44.274] Timer tick, asking Buildbucket for the build status
[03:17:44.651] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:44.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:55:0) after 1m0s
[03:18:44.632] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:55:0)
[03:18:44.632] Timer tick, asking Buildbucket for the build status
[03:18:44.720] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:44.720] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:56:0) after 1m0s
[03:19:44.852] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:56:0)
[03:19:44.852] Timer tick, asking Buildbucket for the build status
[03:19:44.994] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:44.994] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:57:0) after 1m0s
[03:20:45.100] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:57:0)
[03:20:45.100] Timer tick, asking Buildbucket for the build status
[03:20:45.362] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:45.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:58:0) after 1m0s
[03:21:45.372] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:58:0)
[03:21:45.372] Timer tick, asking Buildbucket for the build status
[03:21:45.495] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:45.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:59:0) after 1m0s
[03:22:45.531] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:59:0)
[03:22:45.531] Timer tick, asking Buildbucket for the build status
[03:22:45.641] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:45.641] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:60:0) after 1m0s
[03:23:45.703] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:60:0)
[03:23:45.703] Timer tick, asking Buildbucket for the build status
[03:23:46.347] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:46.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:61:0) after 1m0s
[03:24:46.430] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:61:0)
[03:24:46.430] Timer tick, asking Buildbucket for the build status
[03:24:46.592] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:46.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:62:0) after 1m0s
[03:25:46.602] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:62:0)
[03:25:46.602] Timer tick, asking Buildbucket for the build status
[03:25:47.246] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:47.246] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:63:0) after 1m0s
[03:26:47.301] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:63:0)
[03:26:47.301] Timer tick, asking Buildbucket for the build status
[03:26:47.485] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:47.485] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:64:0) after 1m0s
[03:27:47.498] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:64:0)
[03:27:47.498] Timer tick, asking Buildbucket for the build status
[03:27:47.820] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:47.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:65:0) after 1m0s
[03:28:47.897] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:65:0)
[03:28:47.897] Timer tick, asking Buildbucket for the build status
[03:28:48.002] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:48.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:66:0) after 1m0s
[03:29:48.138] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:66:0)
[03:29:48.138] Timer tick, asking Buildbucket for the build status
[03:29:48.370] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:48.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:67:0) after 1m0s
[03:30:48.731] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:67:0)
[03:30:48.731] Timer tick, asking Buildbucket for the build status
[03:30:48.849] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:48.849] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:68:0) after 1m0s
[03:31:48.933] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:68:0)
[03:31:48.933] Timer tick, asking Buildbucket for the build status
[03:31:49.175] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:49.175] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:69:0) after 1m0s
[03:32:49.215] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:69:0)
[03:32:49.215] Timer tick, asking Buildbucket for the build status
[03:32:49.385] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:49.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:70:0) after 1m0s
[03:33:49.432] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:70:0)
[03:33:49.432] Timer tick, asking Buildbucket for the build status
[03:33:49.520] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:49.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:71:0) after 1m0s
[03:34:49.539] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:71:0)
[03:34:49.539] Timer tick, asking Buildbucket for the build status
[03:34:49.700] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:49.700] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:72:0) after 1m0s
[03:35:49.728] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:72:0)
[03:35:49.729] Timer tick, asking Buildbucket for the build status
[03:35:49.856] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:49.856] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:73:0) after 1m0s
[03:36:49.877] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:73:0)
[03:36:49.877] Timer tick, asking Buildbucket for the build status
[03:36:49.976] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:49.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:74:0) after 1m0s
[03:37:49.977] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:74:0)
[03:37:49.977] Timer tick, asking Buildbucket for the build status
[03:37:50.403] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:50.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:75:0) after 1m0s
[03:38:50.475] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:75:0)
[03:38:50.475] Timer tick, asking Buildbucket for the build status
[03:38:50.578] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:50.578] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:76:0) after 1m0s
[03:39:50.620] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:76:0)
[03:39:50.620] Timer tick, asking Buildbucket for the build status
[03:39:50.735] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:50.735] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:77:0) after 1m0s
[03:40:50.768] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:77:0)
[03:40:50.768] Timer tick, asking Buildbucket for the build status
[03:40:50.891] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:50.891] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:78:0) after 1m0s
[03:41:50.870] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:78:0)
[03:41:50.870] Timer tick, asking Buildbucket for the build status
[03:41:51.022] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:51.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:79:0) after 1m0s
[03:42:51.059] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:79:0)
[03:42:51.059] Timer tick, asking Buildbucket for the build status
[03:42:51.340] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:51.340] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:80:0) after 1m0s
[03:43:51.439] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:80:0)
[03:43:51.439] Timer tick, asking Buildbucket for the build status
[03:43:51.661] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:51.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:81:0) after 1m0s
[03:44:51.695] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:81:0)
[03:44:51.695] Timer tick, asking Buildbucket for the build status
[03:44:51.966] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:51.966] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:82:0) after 1m0s
[03:45:51.998] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:82:0)
[03:45:51.998] Timer tick, asking Buildbucket for the build status
[03:45:52.142] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:52.142] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:83:0) after 1m0s
[03:46:52.167] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:83:0)
[03:46:52.167] Timer tick, asking Buildbucket for the build status
[03:46:52.329] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:52.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:84:0) after 1m0s
[03:47:52.415] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:84:0)
[03:47:52.415] Timer tick, asking Buildbucket for the build status
[03:47:52.568] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:52.568] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:85:0) after 1m0s
[03:48:52.643] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:85:0)
[03:48:52.643] Timer tick, asking Buildbucket for the build status
[03:48:53.033] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:53.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:86:0) after 1m0s
[03:49:53.062] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:86:0)
[03:49:53.062] Timer tick, asking Buildbucket for the build status
[03:49:53.210] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:53.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:87:0) after 1m0s
[03:50:53.248] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:87:0)
[03:50:53.248] Timer tick, asking Buildbucket for the build status
[03:50:53.383] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:53.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:88:0) after 1m0s
[03:51:53.405] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:88:0)
[03:51:53.405] Timer tick, asking Buildbucket for the build status
[03:51:53.557] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:53.557] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:89:0) after 1m0s
[03:52:53.578] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:89:0)
[03:52:53.578] Timer tick, asking Buildbucket for the build status
[03:52:53.723] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:53.723] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:90:0) after 1m0s
[03:53:53.746] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:90:0)
[03:53:53.746] Timer tick, asking Buildbucket for the build status
[03:53:53.890] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:53.890] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:91:0) after 1m0s
[03:54:53.919] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:91:0)
[03:54:53.919] Timer tick, asking Buildbucket for the build status
[03:54:54.208] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:54.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:92:0) after 1m0s
[03:55:54.248] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:92:0)
[03:55:54.248] Timer tick, asking Buildbucket for the build status
[03:55:54.825] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:54.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:93:0) after 1m0s
[03:56:54.859] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:93:0)
[03:56:54.859] Timer tick, asking Buildbucket for the build status
[03:56:55.028] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:55.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:94:0) after 1m0s
[03:57:55.064] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:94:0)
[03:57:55.064] Timer tick, asking Buildbucket for the build status
[03:57:55.178] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:55.178] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:95:0) after 1m0s
[03:58:55.203] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:95:0)
[03:58:55.203] Timer tick, asking Buildbucket for the build status
[03:58:55.636] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:55.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:96:0) after 1m0s
[03:59:55.665] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:96:0)
[03:59:55.665] Timer tick, asking Buildbucket for the build status
[03:59:55.780] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:55.780] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:97:0) after 1m0s
[04:00:55.799] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:97:0)
[04:00:55.799] Timer tick, asking Buildbucket for the build status
[04:00:55.946] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:55.946] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:98:0) after 1m0s
[04:01:56.031] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:98:0)
[04:01:56.031] Timer tick, asking Buildbucket for the build status
[04:01:56.582] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:56.582] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:99:0) after 1m0s
[04:02:56.608] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:99:0)
[04:02:56.608] Timer tick, asking Buildbucket for the build status
[04:02:57.076] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:57.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:100:0) after 1m0s
[04:03:57.100] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:100:0)
[04:03:57.100] Timer tick, asking Buildbucket for the build status
[04:03:57.226] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:57.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:101:0) after 1m0s
[04:04:57.270] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:101:0)
[04:04:57.270] Timer tick, asking Buildbucket for the build status
[04:04:57.444] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:57.444] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:102:0) after 1m0s
[04:05:57.481] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:102:0)
[04:05:57.481] Timer tick, asking Buildbucket for the build status
[04:05:57.615] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:57.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:103:0) after 1m0s
[04:06:57.639] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:103:0)
[04:06:57.639] Timer tick, asking Buildbucket for the build status
[04:06:58.125] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:58.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:104:0) after 1m0s
[04:07:58.166] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:104:0)
[04:07:58.166] Timer tick, asking Buildbucket for the build status
[04:07:58.296] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:58.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:105:0) after 1m0s
[04:08:58.330] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:105:0)
[04:08:58.330] Timer tick, asking Buildbucket for the build status
[04:08:58.422] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:58.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:106:0) after 1m0s
[04:09:58.448] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:106:0)
[04:09:58.448] Timer tick, asking Buildbucket for the build status
[04:09:58.602] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:58.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:107:0) after 1m0s
[04:10:58.636] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:107:0)
[04:10:58.636] Timer tick, asking Buildbucket for the build status
[04:10:58.771] Build 8881993519675396208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:58.771] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9047423581791830160:108:0) after 1m0s
[04:11:30.991] Received PubSub notification, asking Buildbucket for the build status
[04:11:31.383] Build 8881993519675396208: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:11:31.384] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1587874288996757",
"created_by": "project:chromium",
"created_ts": "1587867924006310",
"id": "8881993519675396208",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53f63f71832350e18f342e001a9f3077eb8f723b\"}}",
"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\"}, \"$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-9-9kvk\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux CFI\", \"buildnumber\": 17017, \"got_angle_revision\": \"3cb9c4bee9b369a2172d5c22e6eb70da49a799ed\", \"got_dawn_revision\": \"c244f5392178290ec559d8d62a63038ad79309a8\", \"got_nacl_revision\": \"b599fb88f59e617bfed2cf03729f24be5c378e2c\", \"got_revision\": \"53f63f71832350e18f342e001a9f3077eb8f723b\", \"got_revision_cp\": \"refs/heads/master@{#762675}\", \"got_swarming_client_revision\": \"160b445a44e0daacf6f3f8570ca2707ec451f374\", \"got_swiftshader_revision\": \"60aa34a990fa77553e2d9a69d34f0b3601ced66a\", \"got_v8_revision\": \"0d2d6cca94bc6a2a9eae8dd00de88d923e5b6188\", \"got_v8_revision_cp\": \"refs/heads/8.4.191@{#1}\", \"got_webrtc_revision\": \"1b8ef63876ebfa55a51c8ca9b1d8206bf8233e01\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31130}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.memory\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53f63f71832350e18f342e001a9f3077eb8f723b\", \"swarm_hashes\": {\"accessibility_unittests\": \"c704859fb263d801ef6e6068d22d86d0bbada364\", \"angle_unittests\": \"e9071d7f017f0bc4d3817b3bfcba810087296c43\", \"app_shell_unittests\": \"77b1a3cca0fa0f735426441594f903c91cd278ce\", \"aura_unittests\": \"0e8df4c3210bfa38881e5f75c44ac280de716b32\", \"base_unittests\": \"c6da3d9e688cf98e1805a1e8d4e4bb204d7ca8f9\", \"base_util_unittests\": \"cf023ed3af3e56b3a211e8ce5323657770f5c28d\", \"blink_common_unittests\": \"128de92d54a113a4a34b7cb387efd80f917c6283\", \"blink_fuzzer_unittests\": \"d3c471bb375f565ac78e6c8eba7456e25e0eedc8\", \"blink_heap_unittests\": \"7d00e6431e7f7aacbffe8b399631599bcd6f4c89\", \"blink_platform_unittests\": \"0046d4a67cee5aa4fc30e5088bcdbd65280dab35\", \"blink_unittests\": \"6ead3593938a3b54bc4b6a1694daa00f1f251ad6\", \"boringssl_crypto_tests\": \"4102d97e7f0b20c07aa02b4c6f6ff587b9704390\", \"boringssl_ssl_tests\": \"c9b6702f08ffa3fa562448e2b095d0df2d84f859\", \"browser_tests\": \"6b5bcaa28abd627bbdd4700f9b489e41435d95cb\", \"cacheinvalidation_unittests\": \"7f19be7873e57cadb7626ebb9a3da93e18835911\", \"capture_unittests\": \"6f9ff3bbb120aefe8ed994f1001e385da557d0fa\", \"cast_unittests\": \"527eea897c041b182fdb32fa2a34ee75db2aea85\", \"cc_unittests\": \"20766f1d04a1309b61c3eafd853de696e04724ff\", \"chrome_app_unittests\": \"ccfa95f1996a9c7bb81934aa5e45f4236c4f4739\", \"chromedriver_unittests\": \"71b787969c3f98c540a2e6385e43028438c3c414\", \"components_browsertests\": \"af09f3a483181559b9176ab9301b75abe69579b0\", \"components_unittests\": \"4ba36a62e24f583565ba5c3838f057df27ad15cc\", \"compositor_unittests\": \"100c00dace4cbaf5a902d5bddd8880a4daebdc72\", \"content_browsertests\": \"f93b25625aaae4521191b7e6364d6fb61ff3bbcc\", \"content_unittests\": \"518699866fa2fe4fdf943ecd7bc32de33c4370c6\", \"cronet_tests\": \"7cad34de836cbc8e36f187d27e032e014484326f\", \"cronet_unittests\": \"839771959cb7cf3e0d4918c01f6eb9a6d385c10a\", \"crypto_unittests\": \"e59a45b2c070a022b7baff93ef3748c2caa8f6d1\", \"dbus_unittests\": \"83d12e9f7e91afc046c2e0a84b56288620ad38f6\", \"device_unittests\": \"8f7e6f69cf6db7a721eebb745156e40d8801519a\", \"display_unittests\": \"69af2eef2923bdaf7674df4fc043c79e4423627b\", \"events_unittests\": \"c588a1c410b2885faa8ca8190703fca9a8d9046c\", \"extensions_browsertests\": \"01ad91d1c81733ef4a0551491bff880150cc72e7\", \"extensions_unittests\": \"2e071bc3e648a6a8685e609d8f72f3916f609a34\", \"filesystem_service_unittests\": \"a93e4e221d79136cfe9d2ae5b475d04932484785\", \"gcm_unit_tests\": \"9f4b728b1b06b58955e33cda97c786401f868ede\", \"gfx_unittests\": \"5894b523f03189dec5be74d27ebacd35cc580a58\", \"gin_unittests\": \"b0ae47662627403ae1426dba5be6ad65abe90223\", \"gl_tests\": \"28227a4a4e7e3acad7128a173761e8dd2b4930f6\", \"gl_unittests\": \"3e4c6a062c153979081b5ed62cfaf438b2652c0f\", \"google_apis_unittests\": \"4d5bfaafc3111e31cf8ce7018e17798a2ce4ff09\", \"gpu_unittests\": \"827d88ae2fa3df1f29e469b200dd4eadec02c0a3\", \"gwp_asan_unittests\": \"51b1d47f0500c84faae19e6383cb9ec23a9b5b3c\", \"headless_browsertests\": \"bfa3a27ae2400893dfb8e0ab828d90364c5f471d\", \"headless_unittests\": \"203ac67d0e5ab9e3fbee53d827550acb04d003d4\", \"interactive_ui_tests\": \"01af62e2781d151dd2e07cf300c0257fc2d3c8af\", \"ipc_tests\": \"8346b2563ece3136342010841fbc1165d559673a\", \"jingle_unittests\": \"dd33b480ca160f2b7ba411cb64d668a04bde1e86\", \"latency_unittests\": \"b1fd2dfbd23e58e3c9b2efe9d68b4cf35f3cadce\", \"libjingle_xmpp_unittests\": \"cb19c66c2ce77bf5e756b9be72bcc848636c524e\", \"media_blink_unittests\": \"e640e92566a62735a2e1c3aa291c5e2442168e7e\", \"media_unittests\": \"075e574ba450304aee09ae87c73e53b06ee11e58\", \"message_center_unittests\": \"2c3d659e679e4bba8aee6ce87356f819fcfbc6b2\", \"midi_unittests\": \"3e443d6409e6ce3045032f0f10201dbcdb7b6a4a\", \"mojo_core_unittests\": \"dd2d3cc8af622108bb4c1776e38bc41c1b1b573d\", \"mojo_unittests\": \"3c4bd12ea763d6f799ca034ab464ae91744872d4\", \"nacl_helper_nonsfi_unittests\": \"1b6dd0e875ace786b88491922765b42fd657450d\", \"nacl_loader_unittests\": \"450bd92b5d5ff13dfc57e2b161a65781da2650d3\", \"native_theme_unittests\": \"f152db0451194ef3ee2a0a726889cf5a5f118ecf\", \"net_unittests\": \"77bde036168cff3ca3f6f87764c4f07b95b9091e\", \"pdf_unittests\": \"8b7d85f33e5799b41eeb0612da27c80b9a78d92e\", \"perfetto_unittests\": \"3a94c908ea31038c8828926d87a28ff120b286f2\", \"ppapi_unittests\": \"62143c30dd7ac56d617aad4e091deeb48b1d12c7\", \"printing_unittests\": \"dfde9429d14f38867e190da2b16efc1b2168e39d\", \"remoting_unittests\": \"331416d8d1115049f50cb7b45cbb36e5dd91a53e\", \"sandbox_linux_unittests\": \"0a3c2132770d0a96c8b61416c12f95ef404d1e29\", \"service_manager_unittests\": \"43ded7d18f6ffba4d5e63ee61224ef0b4afa7543\", \"services_unittests\": \"2bffa4aa7048cd018d9905dd5713089496d33657\", \"shell_dialogs_unittests\": \"4658c73577f5f347af6b595efe1376fecd2fed23\", \"skia_unittests\": \"cb3098bfe3f70ced119c99105eac66bfce960561\", \"snapshot_unittests\": \"8f661bae607a8d6970cb28076ea529e82791ee2f\", \"sql_unittests\": \"d83fbf19d682e2d1dbbcf9e2d5a6fdb1be57019a\", \"storage_unittests\": \"19b7d54f1229da6820996218136178ea61e52c48\", \"sync_integration_tests\": \"447c075427e6e1a376152525607e596f5617ff9e\", \"traffic_annotation_auditor_unittests\": \"d02f3094b63d2da0a0bc83618cfdfca769dca61f\", \"ui_base_unittests\": \"d469786dc624f43cd180925b830608e7a2520208\", \"ui_touch_selection_unittests\": \"2a054a9ee9a73a401c0493922b2c85fa67c460c6\", \"unit_tests\": \"5a2ff6742e7c35d29873e0305b0b7d5c9345510a\", \"url_unittests\": \"362d5edff9c4b061413c0db6f4bb3ab8f59f5486\", \"views_unittests\": \"7a14c2b303535350b05051208642fe5744a591e1\", \"viz_unittests\": \"dde0aad612b339b37ee968a5f61e27d9bbf32e83\", \"vr_common_unittests\": \"9abe43faae3ca6bb2b9c0c81484a2843931eaae4\", \"vr_pixeltests\": \"6fd64ba4013ace731e434a027f76f304e209d463\", \"wm_unittests\": \"d905157468c8b0ee96d0320d159cb0c3a5efa8ae\", \"wtf_unittests\": \"8311111d1d1915196b867f3fc93dacf2b1441e32\"}, \"swarm_hashes_refs/heads/master(at){#762675}_without_patch\": {\"accessibility_unittests\": \"c704859fb263d801ef6e6068d22d86d0bbada364\", \"angle_unittests\": \"e9071d7f017f0bc4d3817b3bfcba810087296c43\", \"app_shell_unittests\": \"77b1a3cca0fa0f735426441594f903c91cd278ce\", \"aura_unittests\": \"0e8df4c3210bfa38881e5f75c44ac280de716b32\", \"base_unittests\": \"c6da3d9e688cf98e1805a1e8d4e4bb204d7ca8f9\", \"base_util_unittests\": \"cf023ed3af3e56b3a211e8ce5323657770f5c28d\", \"blink_common_unittests\": \"128de92d54a113a4a34b7cb387efd80f917c6283\", \"blink_fuzzer_unittests\": \"d3c471bb375f565ac78e6c8eba7456e25e0eedc8\", \"blink_heap_unittests\": \"7d00e6431e7f7aacbffe8b399631599bcd6f4c89\", \"blink_platform_unittests\": \"0046d4a67cee5aa4fc30e5088bcdbd65280dab35\", \"blink_unittests\": \"6ead3593938a3b54bc4b6a1694daa00f1f251ad6\", \"boringssl_crypto_tests\": \"4102d97e7f0b20c07aa02b4c6f6ff587b9704390\", \"boringssl_ssl_tests\": \"c9b6702f08ffa3fa562448e2b095d0df2d84f859\", \"browser_tests\": \"6b5bcaa28abd627bbdd4700f9b489e41435d95cb\", \"cacheinvalidation_unittests\": \"7f19be7873e57cadb7626ebb9a3da93e18835911\", \"capture_unittests\": \"6f9ff3bbb120aefe8ed994f1001e385da557d0fa\", \"cast_unittests\": \"527eea897c041b182fdb32fa2a34ee75db2aea85\", \"cc_unittests\": \"20766f1d04a1309b61c3eafd853de696e04724ff\", \"chrome_app_unittests\": \"ccfa95f1996a9c7bb81934aa5e45f4236c4f4739\", \"chromedriver_unittests\": \"71b787969c3f98c540a2e6385e43028438c3c414\", \"components_browsertests\": \"af09f3a483181559b9176ab9301b75abe69579b0\", \"components_unittests\": \"4ba36a62e24f583565ba5c3838f057df27ad15cc\", \"compositor_unittests\": \"100c00dace4cbaf5a902d5bddd8880a4daebdc72\", \"content_browsertests\": \"f93b25625aaae4521191b7e6364d6fb61ff3bbcc\", \"content_unittests\": \"518699866fa2fe4fdf943ecd7bc32de33c4370c6\", \"cronet_tests\": \"7cad34de836cbc8e36f187d27e032e014484326f\", \"cronet_unittests\": \"839771959cb7cf3e0d4918c01f6eb9a6d385c10a\", \"crypto_unittests\": \"e59a45b2c070a022b7baff93ef3748c2caa8f6d1\", \"dbus_unittests\": \"83d12e9f7e91afc046c2e0a84b56288620ad38f6\", \"device_unittests\": \"8f7e6f69cf6db7a721eebb745156e40d8801519a\", \"display_unittests\": \"69af2eef2923bdaf7674df4fc043c79e4423627b\", \"events_unittests\": \"c588a1c410b2885faa8ca8190703fca9a8d9046c\", \"extensions_browsertests\": \"01ad91d1c81733ef4a0551491bff880150cc72e7\", \"extensions_unittests\": \"2e071bc3e648a6a8685e609d8f72f3916f609a34\", \"filesystem_service_unittests\": \"a93e4e221d79136cfe9d2ae5b475d04932484785\", \"gcm_unit_tests\": \"9f4b728b1b06b58955e33cda97c786401f868ede\", \"gfx_unittests\": \"5894b523f03189dec5be74d27ebacd35cc580a58\", \"gin_unittests\": \"b0ae47662627403ae1426dba5be6ad65abe90223\", \"gl_tests\": \"28227a4a4e7e3acad7128a173761e8dd2b4930f6\", \"gl_unittests\": \"3e4c6a062c153979081b5ed62cfaf438b2652c0f\", \"google_apis_unittests\": \"4d5bfaafc3111e31cf8ce7018e17798a2ce4ff09\", \"gpu_unittests\": \"827d88ae2fa3df1f29e469b200dd4eadec02c0a3\", \"gwp_asan_unittests\": \"51b1d47f0500c84faae19e6383cb9ec23a9b5b3c\", \"headless_browsertests\": \"bfa3a27ae2400893dfb8e0ab828d90364c5f471d\", \"headless_unittests\": \"203ac67d0e5ab9e3fbee53d827550acb04d003d4\", \"interactive_ui_tests\": \"01af62e2781d151dd2e07cf300c0257fc2d3c8af\", \"ipc_tests\": \"8346b2563ece3136342010841fbc1165d559673a\", \"jingle_unittests\": \"dd33b480ca160f2b7ba411cb64d668a04bde1e86\", \"latency_unittests\": \"b1fd2dfbd23e58e3c9b2efe9d68b4cf35f3cadce\", \"libjingle_xmpp_unittests\": \"cb19c66c2ce77bf5e756b9be72bcc848636c524e\", \"media_blink_unittests\": \"e640e92566a62735a2e1c3aa291c5e2442168e7e\", \"media_unittests\": \"075e574ba450304aee09ae87c73e53b06ee11e58\", \"message_center_unittests\": \"2c3d659e679e4bba8aee6ce87356f819fcfbc6b2\", \"midi_unittests\": \"3e443d6409e6ce3045032f0f10201dbcdb7b6a4a\", \"mojo_core_unittests\": \"dd2d3cc8af622108bb4c1776e38bc41c1b1b573d\", \"mojo_unittests\": \"3c4bd12ea763d6f799ca034ab464ae91744872d4\", \"nacl_helper_nonsfi_unittests\": \"1b6dd0e875ace786b88491922765b42fd657450d\", \"nacl_loader_unittests\": \"450bd92b5d5ff13dfc57e2b161a65781da2650d3\", \"native_theme_unittests\": \"f152db0451194ef3ee2a0a726889cf5a5f118ecf\", \"net_unittests\": \"77bde036168cff3ca3f6f87764c4f07b95b9091e\", \"pdf_unittests\": \"8b7d85f33e5799b41eeb0612da27c80b9a78d92e\", \"perfetto_unittests\": \"3a94c908ea31038c8828926d87a28ff120b286f2\", \"ppapi_unittests\": \"62143c30dd7ac56d617aad4e091deeb48b1d12c7\", \"printing_unittests\": \"dfde9429d14f38867e190da2b16efc1b2168e39d\", \"remoting_unittests\": \"331416d8d1115049f50cb7b45cbb36e5dd91a53e\", \"sandbox_linux_unittests\": \"0a3c2132770d0a96c8b61416c12f95ef404d1e29\", \"service_manager_unittests\": \"43ded7d18f6ffba4d5e63ee61224ef0b4afa7543\", \"services_unittests\": \"2bffa4aa7048cd018d9905dd5713089496d33657\", \"shell_dialogs_unittests\": \"4658c73577f5f347af6b595efe1376fecd2fed23\", \"skia_unittests\": \"cb3098bfe3f70ced119c99105eac66bfce960561\", \"snapshot_unittests\": \"8f661bae607a8d6970cb28076ea529e82791ee2f\", \"sql_unittests\": \"d83fbf19d682e2d1dbbcf9e2d5a6fdb1be57019a\", \"storage_unittests\": \"19b7d54f1229da6820996218136178ea61e52c48\", \"sync_integration_tests\": \"447c075427e6e1a376152525607e596f5617ff9e\", \"traffic_annotation_auditor_unittests\": \"d02f3094b63d2da0a0bc83618cfdfca769dca61f\", \"ui_base_unittests\": \"d469786dc624f43cd180925b830608e7a2520208\", \"ui_touch_selection_unittests\": \"2a054a9ee9a73a401c0493922b2c85fa67c460c6\", \"unit_tests\": \"5a2ff6742e7c35d29873e0305b0b7d5c9345510a\", \"url_unittests\": \"362d5edff9c4b061413c0db6f4bb3ab8f59f5486\", \"views_unittests\": \"7a14c2b303535350b05051208642fe5744a591e1\", \"viz_unittests\": \"dde0aad612b339b37ee968a5f61e27d9bbf32e83\", \"vr_common_unittests\": \"9abe43faae3ca6bb2b9c0c81484a2843931eaae4\", \"vr_pixeltests\": \"6fd64ba4013ace731e434a027f76f304e209d463\", \"wm_unittests\": \"d905157468c8b0ee96d0320d159cb0c3a5efa8ae\", \"wtf_unittests\": \"8311111d1d1915196b867f3fc93dacf2b1441e32\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0449d4990cc4feb415a65e31e9088077715ff3aab07ec56c1ca7c39b14a8bb8d_v2\", \"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-9-9kvk\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5018-c7f912d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1587868092573931",
"status": "COMPLETED",
"status_changed_ts": "1587874289757196",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/17017",
"builder:Linux CFI",
"buildset:commit/git/53f63f71832350e18f342e001a9f3077eb8f723b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53f63f71832350e18f342e001a9f3077eb8f723b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9047423581791830160",
"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/8881993519675396208/+/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:4bcd1f42a0a62a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1587874289838967",
"url": "https://ci.chromium.org/b/8881993519675396208",
"utcnow_ts": "1587874291370954"
}
}
[04:11:31.384] Invocation finished in 1h46m8.779859069s with status SUCCEEDED