[23:08:48.073] New invocation is queued and will start shortly
[23:08:49.153] Starting the invocation (attempt 1)
[23:08:49.225] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:08:49.225] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:08:49.225] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030856704422118800",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0339be5a73016b5234dd75fb500af2f08f037d65\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9030856704422118800",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/0339be5a73016b5234dd75fb500af2f08f037d65",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0339be5a73016b5234dd75fb500af2f08f037d65",
"gitiles_ref:refs/heads/master"
]
}
[23:08:50.316] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603667329351241",
"id": "8865426642417054992",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0339be5a73016b5234dd75fb500af2f08f037d65\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603667329882456",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/18768",
"builder:Linux CFI",
"buildset:commit/git/0339be5a73016b5234dd75fb500af2f08f037d65",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0339be5a73016b5234dd75fb500af2f08f037d65",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030856704422118800",
"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/8865426642417054992/+/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": "1603667329882846",
"url": "https://ci.chromium.org/b/8865426642417054992",
"utcnow_ts": "1603667330283017"
}
}
[23:08:50.316] Task URL: https://ci.chromium.org/b/8865426642417054992
[23:08:50.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:2:0) after 1m0s
[23:08:54.948] Received PubSub notification, asking Buildbucket for the build status
[23:08:55.154] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:50.333] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:2:0)
[23:09:50.333] Timer tick, asking Buildbucket for the build status
[23:09:50.447] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:50.447] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:4:0) after 1m0s
[23:10:50.504] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:4:0)
[23:10:50.504] Timer tick, asking Buildbucket for the build status
[23:10:50.632] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:50.632] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:5:0) after 1m0s
[23:11:50.645] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:5:0)
[23:11:50.645] Timer tick, asking Buildbucket for the build status
[23:11:50.774] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:50.774] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:6:0) after 1m0s
[23:12:50.792] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:6:0)
[23:12:50.792] Timer tick, asking Buildbucket for the build status
[23:12:51.072] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:51.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:7:0) after 1m0s
[23:13:51.084] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:7:0)
[23:13:51.084] Timer tick, asking Buildbucket for the build status
[23:13:51.312] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:51.312] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:8:0) after 1m0s
[23:14:51.334] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:8:0)
[23:14:51.334] Timer tick, asking Buildbucket for the build status
[23:14:51.459] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:51.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:9:0) after 1m0s
[23:15:51.468] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:9:0)
[23:15:51.468] Timer tick, asking Buildbucket for the build status
[23:15:51.545] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:51.545] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:10:0) after 1m0s
[23:16:51.604] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:10:0)
[23:16:51.604] Timer tick, asking Buildbucket for the build status
[23:16:51.673] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:51.673] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:11:0) after 1m0s
[23:17:51.715] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:11:0)
[23:17:51.715] Timer tick, asking Buildbucket for the build status
[23:17:51.791] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:51.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:12:0) after 1m0s
[23:18:51.893] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:12:0)
[23:18:51.893] Timer tick, asking Buildbucket for the build status
[23:18:52.116] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:52.116] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:13:0) after 1m0s
[23:19:52.180] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:13:0)
[23:19:52.180] Timer tick, asking Buildbucket for the build status
[23:19:52.249] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:52.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:14:0) after 1m0s
[23:20:52.303] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:14:0)
[23:20:52.303] Timer tick, asking Buildbucket for the build status
[23:20:52.369] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:52.369] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:15:0) after 1m0s
[23:21:52.339] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:15:0)
[23:21:52.339] Timer tick, asking Buildbucket for the build status
[23:21:52.401] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:52.401] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:16:0) after 1m0s
[23:22:52.413] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:16:0)
[23:22:52.413] Timer tick, asking Buildbucket for the build status
[23:22:52.488] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:52.489] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:17:0) after 1m0s
[23:23:52.593] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:17:0)
[23:23:52.593] Timer tick, asking Buildbucket for the build status
[23:23:52.761] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:52.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:18:0) after 1m0s
[23:24:52.784] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:18:0)
[23:24:52.784] Timer tick, asking Buildbucket for the build status
[23:24:52.925] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:52.925] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:19:0) after 1m0s
[23:25:53.009] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:19:0)
[23:25:53.009] Timer tick, asking Buildbucket for the build status
[23:25:53.119] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:53.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:20:0) after 1m0s
[23:26:53.189] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:20:0)
[23:26:53.189] Timer tick, asking Buildbucket for the build status
[23:26:53.307] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:53.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:21:0) after 1m0s
[23:27:53.396] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:21:0)
[23:27:53.396] Timer tick, asking Buildbucket for the build status
[23:27:53.506] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:53.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:22:0) after 1m0s
[23:28:53.637] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:22:0)
[23:28:53.637] Timer tick, asking Buildbucket for the build status
[23:28:53.732] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:53.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:23:0) after 1m0s
[23:29:53.790] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:23:0)
[23:29:53.790] Timer tick, asking Buildbucket for the build status
[23:29:54.007] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:54.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:24:0) after 1m0s
[23:30:54.092] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:24:0)
[23:30:54.092] Timer tick, asking Buildbucket for the build status
[23:30:54.164] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:54.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:25:0) after 1m0s
[23:31:54.257] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:25:0)
[23:31:54.257] Timer tick, asking Buildbucket for the build status
[23:31:54.333] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:54.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:26:0) after 1m0s
[23:32:54.366] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:26:0)
[23:32:54.366] Timer tick, asking Buildbucket for the build status
[23:32:54.492] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:54.492] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:27:0) after 1m0s
[23:33:54.516] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:27:0)
[23:33:54.516] Timer tick, asking Buildbucket for the build status
[23:33:54.648] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:54.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:28:0) after 1m0s
[23:34:54.702] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:28:0)
[23:34:54.702] Timer tick, asking Buildbucket for the build status
[23:34:54.990] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:54.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:29:0) after 1m0s
[23:35:55.086] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:29:0)
[23:35:55.086] Timer tick, asking Buildbucket for the build status
[23:35:55.410] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:55.410] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:30:0) after 1m0s
[23:36:55.444] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:30:0)
[23:36:55.444] Timer tick, asking Buildbucket for the build status
[23:36:55.508] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:55.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:31:0) after 1m0s
[23:37:56.971] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:31:0)
[23:37:56.971] Timer tick, asking Buildbucket for the build status
[23:37:57.062] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:57.062] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:32:0) after 1m0s
[23:38:57.315] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:32:0)
[23:38:57.315] Timer tick, asking Buildbucket for the build status
[23:38:57.443] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:57.443] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:33:0) after 1m0s
[23:39:57.570] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:33:0)
[23:39:57.571] Timer tick, asking Buildbucket for the build status
[23:39:57.648] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:57.648] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:34:0) after 1m0s
[23:40:57.821] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:34:0)
[23:40:57.821] Timer tick, asking Buildbucket for the build status
[23:40:57.899] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:57.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:35:0) after 1m0s
[23:41:58.089] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:35:0)
[23:41:58.089] Timer tick, asking Buildbucket for the build status
[23:41:58.209] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:58.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:36:0) after 1m0s
[23:42:58.328] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:36:0)
[23:42:58.328] Timer tick, asking Buildbucket for the build status
[23:42:58.383] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:58.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:37:0) after 1m0s
[23:43:58.436] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:37:0)
[23:43:58.436] Timer tick, asking Buildbucket for the build status
[23:43:58.913] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:58.913] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:38:0) after 1m0s
[23:44:58.961] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:38:0)
[23:44:58.961] Timer tick, asking Buildbucket for the build status
[23:44:59.109] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:59.109] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:39:0) after 1m0s
[23:45:59.172] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:39:0)
[23:45:59.172] Timer tick, asking Buildbucket for the build status
[23:45:59.249] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:59.249] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:40:0) after 1m0s
[23:46:59.339] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:40:0)
[23:46:59.339] Timer tick, asking Buildbucket for the build status
[23:46:59.417] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:59.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:41:0) after 1m0s
[23:47:59.495] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:41:0)
[23:47:59.495] Timer tick, asking Buildbucket for the build status
[23:47:59.562] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:59.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:42:0) after 1m0s
[23:48:59.563] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:42:0)
[23:48:59.563] Timer tick, asking Buildbucket for the build status
[23:48:59.977] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:59.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:43:0) after 1m0s
[23:50:00.091] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:43:0)
[23:50:00.091] Timer tick, asking Buildbucket for the build status
[23:50:00.244] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:00.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:44:0) after 1m0s
[23:51:00.331] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:44:0)
[23:51:00.331] Timer tick, asking Buildbucket for the build status
[23:51:00.423] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:00.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:45:0) after 1m0s
[23:52:00.608] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:45:0)
[23:52:00.608] Timer tick, asking Buildbucket for the build status
[23:52:00.873] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:00.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:46:0) after 1m0s
[23:53:01.832] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:46:0)
[23:53:01.832] Timer tick, asking Buildbucket for the build status
[23:53:01.904] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:01.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:47:0) after 1m0s
[23:54:02.156] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:47:0)
[23:54:02.156] Timer tick, asking Buildbucket for the build status
[23:54:02.420] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:02.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:48:0) after 1m0s
[23:55:02.970] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:48:0)
[23:55:02.970] Timer tick, asking Buildbucket for the build status
[23:55:03.057] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:03.057] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:49:0) after 1m0s
[23:56:03.148] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:49:0)
[23:56:03.148] Timer tick, asking Buildbucket for the build status
[23:56:03.216] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:03.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:50:0) after 1m0s
[23:57:03.404] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:50:0)
[23:57:03.404] Timer tick, asking Buildbucket for the build status
[23:57:03.482] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:03.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:51:0) after 1m0s
[23:58:03.611] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:51:0)
[23:58:03.611] Timer tick, asking Buildbucket for the build status
[23:58:03.801] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:03.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:52:0) after 1m0s
[23:59:06.496] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:52:0)
[23:59:06.496] Timer tick, asking Buildbucket for the build status
[23:59:09.416] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:09.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:53:0) after 1m0s
[00:00:09.585] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:53:0)
[00:00:09.585] Timer tick, asking Buildbucket for the build status
[00:00:10.073] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:10.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:54:0) after 1m0s
[00:01:10.568] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:54:0)
[00:01:10.568] Timer tick, asking Buildbucket for the build status
[00:01:10.707] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:10.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:55:0) after 1m0s
[00:02:10.920] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:55:0)
[00:02:10.920] Timer tick, asking Buildbucket for the build status
[00:02:11.003] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:11.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:56:0) after 1m0s
[00:03:11.265] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:56:0)
[00:03:11.265] Timer tick, asking Buildbucket for the build status
[00:03:11.422] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:11.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:57:0) after 1m0s
[00:04:11.469] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:57:0)
[00:04:11.469] Timer tick, asking Buildbucket for the build status
[00:04:11.572] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:11.572] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:58:0) after 1m0s
[00:05:11.666] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:58:0)
[00:05:11.666] Timer tick, asking Buildbucket for the build status
[00:05:11.743] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:11.743] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:59:0) after 1m0s
[00:06:11.854] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:59:0)
[00:06:11.854] Timer tick, asking Buildbucket for the build status
[00:06:12.166] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:12.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:60:0) after 1m0s
[00:07:12.175] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:60:0)
[00:07:12.175] Timer tick, asking Buildbucket for the build status
[00:07:12.283] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:12.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:61:0) after 1m0s
[00:08:12.316] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:61:0)
[00:08:12.316] Timer tick, asking Buildbucket for the build status
[00:08:12.383] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:12.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:62:0) after 1m0s
[00:09:12.511] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:62:0)
[00:09:12.511] Timer tick, asking Buildbucket for the build status
[00:09:12.763] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:12.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:63:0) after 1m0s
[00:10:12.982] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:63:0)
[00:10:12.982] Timer tick, asking Buildbucket for the build status
[00:10:13.066] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:13.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:64:0) after 1m0s
[00:11:13.108] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:64:0)
[00:11:13.108] Timer tick, asking Buildbucket for the build status
[00:11:13.168] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:13.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:65:0) after 1m0s
[00:12:13.248] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:65:0)
[00:12:13.248] Timer tick, asking Buildbucket for the build status
[00:12:13.421] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:13.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:66:0) after 1m0s
[00:13:13.519] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:66:0)
[00:13:13.519] Timer tick, asking Buildbucket for the build status
[00:13:13.588] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:13.588] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:67:0) after 1m0s
[00:14:13.699] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:67:0)
[00:14:13.699] Timer tick, asking Buildbucket for the build status
[00:14:14.027] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:14.027] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:68:0) after 1m0s
[00:15:14.118] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:68:0)
[00:15:14.118] Timer tick, asking Buildbucket for the build status
[00:15:14.193] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:14.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:69:0) after 1m0s
[00:16:14.223] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:69:0)
[00:16:14.223] Timer tick, asking Buildbucket for the build status
[00:16:14.297] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:14.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:70:0) after 1m0s
[00:17:14.320] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:70:0)
[00:17:14.320] Timer tick, asking Buildbucket for the build status
[00:17:14.730] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:14.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:71:0) after 1m0s
[00:18:14.812] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:71:0)
[00:18:14.812] Timer tick, asking Buildbucket for the build status
[00:18:14.891] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:14.891] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:72:0) after 1m0s
[00:19:14.913] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:72:0)
[00:19:14.913] Timer tick, asking Buildbucket for the build status
[00:19:15.296] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:15.296] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:73:0) after 1m0s
[00:20:15.391] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:73:0)
[00:20:15.391] Timer tick, asking Buildbucket for the build status
[00:20:15.467] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:15.467] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:74:0) after 1m0s
[00:21:16.325] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:74:0)
[00:21:16.325] Timer tick, asking Buildbucket for the build status
[00:21:16.508] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:16.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:75:0) after 1m0s
[00:22:16.656] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:75:0)
[00:22:16.656] Timer tick, asking Buildbucket for the build status
[00:22:16.761] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:16.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:76:0) after 1m0s
[00:23:16.852] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:76:0)
[00:23:16.852] Timer tick, asking Buildbucket for the build status
[00:23:16.921] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:16.921] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:77:0) after 1m0s
[00:24:17.186] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:77:0)
[00:24:17.186] Timer tick, asking Buildbucket for the build status
[00:24:17.310] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:17.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:78:0) after 1m0s
[00:25:17.384] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:78:0)
[00:25:17.384] Timer tick, asking Buildbucket for the build status
[00:25:17.442] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:17.442] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:79:0) after 1m0s
[00:26:17.547] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:79:0)
[00:26:17.547] Timer tick, asking Buildbucket for the build status
[00:26:17.613] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:17.613] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:80:0) after 1m0s
[00:27:17.659] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:80:0)
[00:27:17.659] Timer tick, asking Buildbucket for the build status
[00:27:17.763] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:17.763] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:81:0) after 1m0s
[00:28:17.977] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:81:0)
[00:28:17.977] Timer tick, asking Buildbucket for the build status
[00:28:18.099] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:18.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:82:0) after 1m0s
[00:29:18.201] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:82:0)
[00:29:18.201] Timer tick, asking Buildbucket for the build status
[00:29:18.459] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:18.459] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:83:0) after 1m0s
[00:30:18.588] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:83:0)
[00:30:18.588] Timer tick, asking Buildbucket for the build status
[00:30:18.667] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:18.667] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:84:0) after 1m0s
[00:31:18.726] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:84:0)
[00:31:18.726] Timer tick, asking Buildbucket for the build status
[00:31:18.784] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:18.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:85:0) after 1m0s
[00:32:18.807] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:85:0)
[00:32:18.807] Timer tick, asking Buildbucket for the build status
[00:32:18.889] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:18.889] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:86:0) after 1m0s
[00:33:19.007] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:86:0)
[00:33:19.007] Timer tick, asking Buildbucket for the build status
[00:33:19.231] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:19.231] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:87:0) after 1m0s
[00:34:19.879] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:87:0)
[00:34:19.879] Timer tick, asking Buildbucket for the build status
[00:34:19.977] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:19.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:88:0) after 1m0s
[00:35:20.013] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:88:0)
[00:35:20.013] Timer tick, asking Buildbucket for the build status
[00:35:20.079] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:20.079] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:89:0) after 1m0s
[00:36:20.224] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:89:0)
[00:36:20.224] Timer tick, asking Buildbucket for the build status
[00:36:20.352] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:20.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:90:0) after 1m0s
[00:37:20.366] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:90:0)
[00:37:20.366] Timer tick, asking Buildbucket for the build status
[00:37:20.508] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:20.508] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:91:0) after 1m0s
[00:38:20.664] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:91:0)
[00:38:20.664] Timer tick, asking Buildbucket for the build status
[00:38:20.826] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:20.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:92:0) after 1m0s
[00:39:21.141] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:92:0)
[00:39:21.141] Timer tick, asking Buildbucket for the build status
[00:39:21.255] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:21.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:93:0) after 1m0s
[00:40:21.368] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:93:0)
[00:40:21.368] Timer tick, asking Buildbucket for the build status
[00:40:21.707] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:21.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:94:0) after 1m0s
[00:41:21.832] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:94:0)
[00:41:21.832] Timer tick, asking Buildbucket for the build status
[00:41:21.955] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:21.955] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:95:0) after 1m0s
[00:42:22.063] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:95:0)
[00:42:22.063] Timer tick, asking Buildbucket for the build status
[00:42:22.179] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:22.180] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:96:0) after 1m0s
[00:43:22.303] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:96:0)
[00:43:22.303] Timer tick, asking Buildbucket for the build status
[00:43:22.519] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:22.519] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:97:0) after 1m0s
[00:44:22.691] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:97:0)
[00:44:22.691] Timer tick, asking Buildbucket for the build status
[00:44:22.814] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:22.814] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:98:0) after 1m0s
[00:45:22.939] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:98:0)
[00:45:22.939] Timer tick, asking Buildbucket for the build status
[00:45:23.022] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:23.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:99:0) after 1m0s
[00:46:23.168] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:99:0)
[00:46:23.168] Timer tick, asking Buildbucket for the build status
[00:46:23.241] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:23.241] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:100:0) after 1m0s
[00:47:23.299] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:100:0)
[00:47:23.299] Timer tick, asking Buildbucket for the build status
[00:47:23.388] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:23.388] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:101:0) after 1m0s
[00:48:23.414] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:101:0)
[00:48:23.414] Timer tick, asking Buildbucket for the build status
[00:48:23.903] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:23.903] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:102:0) after 1m0s
[00:49:24.132] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:102:0)
[00:49:24.132] Timer tick, asking Buildbucket for the build status
[00:49:24.242] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:24.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:103:0) after 1m0s
[00:50:24.760] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:103:0)
[00:50:24.760] Timer tick, asking Buildbucket for the build status
[00:50:24.844] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:24.844] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:104:0) after 1m0s
[00:51:24.895] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:104:0)
[00:51:24.895] Timer tick, asking Buildbucket for the build status
[00:51:24.992] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:24.992] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:105:0) after 1m0s
[00:52:25.518] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:105:0)
[00:52:25.518] Timer tick, asking Buildbucket for the build status
[00:52:25.598] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:25.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:106:0) after 1m0s
[00:53:25.807] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:106:0)
[00:53:25.807] Timer tick, asking Buildbucket for the build status
[00:53:25.883] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:25.883] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:107:0) after 1m0s
[00:54:26.337] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:107:0)
[00:54:26.337] Timer tick, asking Buildbucket for the build status
[00:54:26.917] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:26.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:108:0) after 1m0s
[00:55:27.221] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:108:0)
[00:55:27.222] Timer tick, asking Buildbucket for the build status
[00:55:27.316] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:27.316] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:109:0) after 1m0s
[00:56:27.610] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:109:0)
[00:56:27.610] Timer tick, asking Buildbucket for the build status
[00:56:27.681] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:27.681] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:110:0) after 1m0s
[00:57:27.885] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:110:0)
[00:57:27.885] Timer tick, asking Buildbucket for the build status
[00:57:27.976] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:27.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:111:0) after 1m0s
[00:58:28.020] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:111:0)
[00:58:28.020] Timer tick, asking Buildbucket for the build status
[00:58:28.231] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:28.231] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:112:0) after 1m0s
[00:59:30.963] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:112:0)
[00:59:30.963] Timer tick, asking Buildbucket for the build status
[00:59:31.372] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:31.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:113:0) after 1m0s
[01:00:31.458] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:113:0)
[01:00:31.458] Timer tick, asking Buildbucket for the build status
[01:00:31.631] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:31.631] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:114:0) after 1m0s
[01:01:31.760] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:114:0)
[01:01:31.760] Timer tick, asking Buildbucket for the build status
[01:01:31.892] Build 8865426642417054992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:31.892] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030856704422118800:115:0) after 1m0s
[01:02:11.315] Received PubSub notification, asking Buildbucket for the build status
[01:02:11.392] Build 8865426642417054992: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:02:11.392] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603674129180690",
"created_by": "project:chromium",
"created_ts": "1603667329351241",
"id": "8865426642417054992",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0339be5a73016b5234dd75fb500af2f08f037d65\"}}",
"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\": \"0339be5a73016b5234dd75fb500af2f08f037d65\", \"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\": 18768, \"got_angle_revision\": \"9e3eec5464d66627144c5fe94f220309158ea2cf\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"0339be5a73016b5234dd75fb500af2f08f037d65\", \"got_revision_cp\": \"refs/heads/master@{#820637}\", \"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\": \"0339be5a73016b5234dd75fb500af2f08f037d65\", \"swarm_hashes_refs/heads/master(at){#820637}_without_patch\": {\"absl_hardening_tests\": \"64f62512e9f03cbf530bff5711b084547b2ef664\", \"accessibility_unittests\": \"659e1d8881ead7b3c16a119ba449413157999bc6\", \"angle_unittests\": \"c689ddab1381646afc424f3c99eac8ddc9f51610\", \"app_shell_unittests\": \"f434445d0c3add822e7936fc15094da34c966f8e\", \"aura_unittests\": \"e737e5c1abd4f5c026514716d563c4d0079f6180\", \"base_unittests\": \"6c4ed79285daf6081f34b2f9bb7e635e41abf453\", \"base_util_unittests\": \"bd7ba5f422993e3378e5f50327aef1d8f9db4923\", \"blink_common_unittests\": \"a36d685f53f1d9d5b782a2aca5b25949dc3c39aa\", \"blink_fuzzer_unittests\": \"93a25f5e264f1aec79653fbe25b9037b52b6d6e2\", \"blink_heap_unittests\": \"5d8b177419df0142c230fa36a80d7520d6278a25\", \"blink_platform_unittests\": \"d5e156a81caea813c4efc14c4026c967d0607d4d\", \"blink_unittests\": \"c1fc0b7a952f3fc2514559a47c6ec0d4409fee0f\", \"boringssl_crypto_tests\": \"e149e781e9928a29b4dd9583f17cfba686900c7b\", \"boringssl_ssl_tests\": \"67e991e557e4bcf147544aa74198c7c6c19a1c54\", \"browser_tests\": \"745f4e7941279f0115235d42be13eeb04a704b7f\", \"capture_unittests\": \"489221a3a5b5a7581467020cbf62bc289f87f2c6\", \"cast_unittests\": \"521add428123f4bfbbaa89f8be864e3de28e3295\", \"cc_unittests\": \"5eb4e0ab27efe36ab5be4617de59dabd7ad04418\", \"chrome_app_unittests\": \"88933d9646d64dddd4a90f76b7b0dd55ffe3a636\", \"chromedriver_unittests\": \"456bd3f432aaf27dcca5fae122f5352c446e28ec\", \"components_browsertests\": \"1aca75fd7a81ff6ff4bab78b718c68ec58756067\", \"components_unittests\": \"ccdca89e801a02006cc2d90d8935d917fbf51c1d\", \"compositor_unittests\": \"4f4b8b366ddfd7774e1d8466b7b4d32c361cc013\", \"content_browsertests\": \"8b430e43a792592e629c2621b3e00c030c2e1964\", \"content_unittests\": \"ab060393e088818d5683860caeaf385d22436723\", \"cronet_tests\": \"8a6906d066bac73fdc0cab61beee5c142ccd5d27\", \"cronet_unittests\": \"6aaef5946e0b40575c7349514f6781966a6d7b2d\", \"crypto_unittests\": \"1fa4a8923d25457a5b0e23a99d4d2bede6a7ceba\", \"dbus_unittests\": \"0182c7b13835f4cce4225d6092d3350a1308b816\", \"device_unittests\": \"7072a2da779517364a65cbb61f4665cefc407692\", \"display_unittests\": \"b083b1ea9576796a2858c957c0909fb1146e195e\", \"events_unittests\": \"5dab2c60f69883b9c6689c441ae2764e2b11d579\", \"extensions_browsertests\": \"98c207aa6112e537074efa04696ede4b95f33665\", \"extensions_unittests\": \"7cf3e377d00dc4f90ed303ce9c8eb12eb6a1959e\", \"filesystem_service_unittests\": \"2bb333643bcb36a135fd6714b5f327ee11cc718d\", \"gcm_unit_tests\": \"7307effccef0d30f1cb4a52b77a464a4d6a2acbb\", \"gfx_unittests\": \"9d2925415d170443fa8fde393a3da6a3ba15b8d5\", \"gin_unittests\": \"bd528d53cfacc7a2bbf1957bc96d1be081594092\", \"gl_tests\": \"cac4c5ee3c7aa97e847b57aef01adc7163d23451\", \"gl_unittests\": \"75d828a88421b96ce45e441dc474f3f281b03747\", \"google_apis_unittests\": \"d2c7c8271e96e2624cadce9a0545cffb9eff560c\", \"gpu_unittests\": \"8140e2c296ebbd0367b30de38a22841936f7b2c1\", \"gwp_asan_unittests\": \"9b4c1237e71d0d3384f222e9fd8250de35a3b406\", \"headless_browsertests\": \"7acf07289266f0a35e32df1804f344967a024501\", \"headless_unittests\": \"2cf79751216aad25cdb2b8567ece3b357222110d\", \"interactive_ui_tests\": \"d5c8228cbb0c86b18c6003b112953fd4b508a428\", \"ipc_tests\": \"a4d94a368215d9d345e814b042dcce7ac33f25ed\", \"jingle_unittests\": \"3140f400d2c1a870a3d812f629f67900d7500f63\", \"latency_unittests\": \"b9c1ec9b7ccc127eeb829a92f18bb8f9ef27990c\", \"libjingle_xmpp_unittests\": \"04bc62d64e01dd731326a93760cec313311785d2\", \"media_blink_unittests\": \"30c5ba12687d38b69489d5f632ee63be2ed2d187\", \"media_unittests\": \"e36cc953672089e32dc112e5e1157433b281e9ef\", \"message_center_unittests\": \"602336425a5f0f56e513371a52ee9fd2eeea5323\", \"midi_unittests\": \"0abd54edda4ebf01018e9d9c5bc061b2ad985c84\", \"mojo_core_unittests\": \"f11ade16466cc34749b7a32dbc3aca860f9a8d20\", \"mojo_unittests\": \"6372fdb1cb4e466b6475710524c27c8bfdcdafcb\", \"nacl_helper_nonsfi_unittests\": \"2ee71dae2e47ae9d8a7e39a784c5186400d7319d\", \"nacl_loader_unittests\": \"1a41744bbad88d34094fc6196c25707c4d209a53\", \"native_theme_unittests\": \"054ee7039471ff4c8835f8ad9704397c9d2a297a\", \"net_unittests\": \"653cbf6086987250af9d460b52c012a3d8f74cee\", \"pdf_unittests\": \"cd2b62073b492b70c39c9b2b55838444a8ac3f54\", \"perfetto_unittests\": \"f52f5e9c31bddf461a7f0a9cc7119b1210c495d0\", \"ppapi_unittests\": \"27683f1f04f094267154d05bcfb414fe25e7e165\", \"printing_unittests\": \"5a91abcc60a12801d822189e99993f383a90af35\", \"remoting_unittests\": \"6fd3f1048953079f0ccbba6459d9f3a2cd9a300c\", \"sandbox_linux_unittests\": \"7a9d081b42297dcd6d9879ba15d2147670786d1a\", \"service_manager_unittests\": \"ed6710718d1533a35d0d33ffb196c22619004ac8\", \"services_unittests\": \"76f7f88abd4517973d21ff8b5553adf6514be6c5\", \"shell_dialogs_unittests\": \"c53ffdb08c6bc5b09fd40dfbcfa5306d361e587d\", \"skia_unittests\": \"ca5c1aea2304b33ea083b8bf3f9eb9c73ba02bd5\", \"snapshot_unittests\": \"e85d057e7fb02c2e894d53f220df182b87a13f0b\", \"sql_unittests\": \"6824602b65e1d34bad5d7b33da6d089fb19ad4af\", \"storage_unittests\": \"037ad9ece8bd3e8831d91279ba1672f9f8b96ec3\", \"sync_integration_tests\": \"ab18453dce6dff2ae953e6e38b4d182af41902fb\", \"traffic_annotation_auditor_unittests\": \"955e2c3d311b7a44b732e8f58efc6c360097ab94\", \"ui_base_unittests\": \"9befd833d7c9a4674580529bea7f1334901331a8\", \"ui_touch_selection_unittests\": \"71ad941ae43f572ec2acc9619c1fa5c64647670e\", \"unit_tests\": \"8d12477de91ab220263197340959e36d17b96b05\", \"url_unittests\": \"f939f523c4c4deb05921789ac76b9aaf5d747b47\", \"views_unittests\": \"9d4a62f9477579bbf490d84644986f89bf6a344e\", \"viz_unittests\": \"2f7db4433c7472314cdf5f2890f759de3e2d8d71\", \"vr_common_unittests\": \"21521de904fb3538ff67738ce6e423e7fe5bfc12\", \"vr_pixeltests\": \"307e64db7364ff8c4d627da1dd6e6d70b141967a\", \"wm_unittests\": \"5730b7200d92b8bdf1ac9b651e4fba03463e42cb\", \"wtf_unittests\": \"fc23afedcc4ae4fb17410b43b6f9c41b9abf0a0e\", \"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": "1603667333051427",
"status": "COMPLETED",
"status_changed_ts": "1603674129680526",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/18768",
"builder:Linux CFI",
"buildset:commit/git/0339be5a73016b5234dd75fb500af2f08f037d65",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0339be5a73016b5234dd75fb500af2f08f037d65",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030856704422118800",
"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/8865426642417054992/+/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:4f7ad70ed263d910",
"user_agent:luci-scheduler"
],
"updated_ts": "1603674129709235",
"url": "https://ci.chromium.org/b/8865426642417054992",
"utcnow_ts": "1603674131382387"
}
}
[01:02:11.392] Invocation finished in 1h53m23.336894772s with status SUCCEEDED