[01:02:13.234] New invocation is queued and will start shortly
[01:02:14.356] Starting the invocation (attempt 1)
[01:02:14.404] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:02:14.404] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:02:14.405] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030849568693608768",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"848cbda800711ac828ce256fffa49eaf13b7ef4e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9030849568693608768",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/848cbda800711ac828ce256fffa49eaf13b7ef4e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/848cbda800711ac828ce256fffa49eaf13b7ef4e",
"gitiles_ref:refs/heads/master"
]
}
[01:02:15.898] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603674134672209",
"id": "8865419506520049136",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"848cbda800711ac828ce256fffa49eaf13b7ef4e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603674135618454",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/18769",
"builder:Linux CFI",
"buildset:commit/git/848cbda800711ac828ce256fffa49eaf13b7ef4e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/848cbda800711ac828ce256fffa49eaf13b7ef4e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030849568693608768",
"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/8865419506520049136/+/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": "1603674135618592",
"url": "https://ci.chromium.org/b/8865419506520049136",
"utcnow_ts": "1603674135883074"
}
}
[01:02:15.898] Task URL: https://ci.chromium.org/b/8865419506520049136
[01:02:15.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:2:0) after 1m0s
[01:02:17.820] Received PubSub notification, asking Buildbucket for the build status
[01:02:18.178] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:15.953] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:2:0)
[01:03:15.953] Timer tick, asking Buildbucket for the build status
[01:03:16.068] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:16.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:4:0) after 1m0s
[01:04:16.155] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:4:0)
[01:04:16.155] Timer tick, asking Buildbucket for the build status
[01:04:16.210] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:16.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:5:0) after 1m0s
[01:05:16.234] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:5:0)
[01:05:16.235] Timer tick, asking Buildbucket for the build status
[01:05:16.476] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:16.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:6:0) after 1m0s
[01:06:16.498] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:6:0)
[01:06:16.498] Timer tick, asking Buildbucket for the build status
[01:06:16.615] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:16.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:7:0) after 1m0s
[01:07:16.635] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:7:0)
[01:07:16.635] Timer tick, asking Buildbucket for the build status
[01:07:16.707] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:16.707] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:8:0) after 1m0s
[01:08:16.763] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:8:0)
[01:08:16.763] Timer tick, asking Buildbucket for the build status
[01:08:16.865] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:16.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:9:0) after 1m0s
[01:09:16.902] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:9:0)
[01:09:16.902] Timer tick, asking Buildbucket for the build status
[01:09:17.357] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:17.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:10:0) after 1m0s
[01:10:17.389] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:10:0)
[01:10:17.389] Timer tick, asking Buildbucket for the build status
[01:10:17.456] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:17.456] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:11:0) after 1m0s
[01:11:17.474] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:11:0)
[01:11:17.474] Timer tick, asking Buildbucket for the build status
[01:11:17.723] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:17.723] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:12:0) after 1m0s
[01:12:17.737] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:12:0)
[01:12:17.737] Timer tick, asking Buildbucket for the build status
[01:12:17.841] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:17.841] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:13:0) after 1m0s
[01:13:17.860] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:13:0)
[01:13:17.860] Timer tick, asking Buildbucket for the build status
[01:13:17.980] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:17.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:14:0) after 1m0s
[01:14:18.004] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:14:0)
[01:14:18.004] Timer tick, asking Buildbucket for the build status
[01:14:18.061] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:18.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:15:0) after 1m0s
[01:15:18.097] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:15:0)
[01:15:18.097] Timer tick, asking Buildbucket for the build status
[01:15:18.307] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:18.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:16:0) after 1m0s
[01:16:18.326] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:16:0)
[01:16:18.326] Timer tick, asking Buildbucket for the build status
[01:16:18.397] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:18.397] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:17:0) after 1m0s
[01:17:18.422] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:17:0)
[01:17:18.422] Timer tick, asking Buildbucket for the build status
[01:17:18.533] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:18.533] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:18:0) after 1m0s
[01:18:18.558] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:18:0)
[01:18:18.558] Timer tick, asking Buildbucket for the build status
[01:18:18.630] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:18.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:19:0) after 1m0s
[01:19:18.657] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:19:0)
[01:19:18.657] Timer tick, asking Buildbucket for the build status
[01:19:18.717] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:18.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:20:0) after 1m0s
[01:20:18.779] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:20:0)
[01:20:18.779] Timer tick, asking Buildbucket for the build status
[01:20:18.900] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:18.900] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:21:0) after 1m0s
[01:21:18.985] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:21:0)
[01:21:18.985] Timer tick, asking Buildbucket for the build status
[01:21:19.042] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:19.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:22:0) after 1m0s
[01:22:19.075] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:22:0)
[01:22:19.075] Timer tick, asking Buildbucket for the build status
[01:22:19.207] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:19.207] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:23:0) after 1m0s
[01:23:19.227] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:23:0)
[01:23:19.227] Timer tick, asking Buildbucket for the build status
[01:23:19.309] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:19.309] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:24:0) after 1m0s
[01:24:19.328] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:24:0)
[01:24:19.328] Timer tick, asking Buildbucket for the build status
[01:24:19.395] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:19.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:25:0) after 1m0s
[01:25:19.418] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:25:0)
[01:25:19.418] Timer tick, asking Buildbucket for the build status
[01:25:19.470] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:19.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:26:0) after 1m0s
[01:26:19.493] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:26:0)
[01:26:19.493] Timer tick, asking Buildbucket for the build status
[01:26:19.599] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:19.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:27:0) after 1m0s
[01:27:19.715] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:27:0)
[01:27:19.715] Timer tick, asking Buildbucket for the build status
[01:27:19.820] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:19.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:28:0) after 1m0s
[01:28:19.842] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:28:0)
[01:28:19.842] Timer tick, asking Buildbucket for the build status
[01:28:19.913] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:19.913] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:29:0) after 1m0s
[01:29:19.935] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:29:0)
[01:29:19.935] Timer tick, asking Buildbucket for the build status
[01:29:20.031] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:20.031] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:30:0) after 1m0s
[01:30:20.062] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:30:0)
[01:30:20.062] Timer tick, asking Buildbucket for the build status
[01:30:20.116] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:20.116] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:31:0) after 1m0s
[01:31:20.216] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:31:0)
[01:31:20.216] Timer tick, asking Buildbucket for the build status
[01:31:20.293] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:20.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:32:0) after 1m0s
[01:32:20.319] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:32:0)
[01:32:20.319] Timer tick, asking Buildbucket for the build status
[01:32:20.419] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:20.419] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:33:0) after 1m0s
[01:33:20.443] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:33:0)
[01:33:20.443] Timer tick, asking Buildbucket for the build status
[01:33:20.526] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:20.526] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:34:0) after 1m0s
[01:34:20.598] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:34:0)
[01:34:20.598] Timer tick, asking Buildbucket for the build status
[01:34:20.682] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:20.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:35:0) after 1m0s
[01:35:20.785] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:35:0)
[01:35:20.785] Timer tick, asking Buildbucket for the build status
[01:35:20.847] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:20.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:36:0) after 1m0s
[01:36:27.534] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:36:0)
[01:36:27.534] Timer tick, asking Buildbucket for the build status
[01:36:27.591] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:27.591] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:37:0) after 1m0s
[01:37:27.615] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:37:0)
[01:37:27.615] Timer tick, asking Buildbucket for the build status
[01:37:27.787] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:27.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:38:0) after 1m0s
[01:38:27.843] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:38:0)
[01:38:27.843] Timer tick, asking Buildbucket for the build status
[01:38:28.046] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:28.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:39:0) after 1m0s
[01:39:28.108] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:39:0)
[01:39:28.108] Timer tick, asking Buildbucket for the build status
[01:39:28.177] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:28.177] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:40:0) after 1m0s
[01:40:28.224] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:40:0)
[01:40:28.224] Timer tick, asking Buildbucket for the build status
[01:40:28.287] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:28.287] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:41:0) after 1m0s
[01:41:28.384] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:41:0)
[01:41:28.384] Timer tick, asking Buildbucket for the build status
[01:41:28.621] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:28.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:42:0) after 1m0s
[01:42:28.689] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:42:0)
[01:42:28.689] Timer tick, asking Buildbucket for the build status
[01:42:28.979] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:28.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:43:0) after 1m0s
[01:43:29.032] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:43:0)
[01:43:29.032] Timer tick, asking Buildbucket for the build status
[01:43:29.209] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:29.209] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:44:0) after 1m0s
[01:44:29.231] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:44:0)
[01:44:29.231] Timer tick, asking Buildbucket for the build status
[01:44:29.293] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:29.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:45:0) after 1m0s
[01:45:29.385] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:45:0)
[01:45:29.385] Timer tick, asking Buildbucket for the build status
[01:45:29.708] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:29.708] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:46:0) after 1m0s
[01:46:29.756] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:46:0)
[01:46:29.756] Timer tick, asking Buildbucket for the build status
[01:46:29.826] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:29.826] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:47:0) after 1m0s
[01:47:29.946] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:47:0)
[01:47:29.946] Timer tick, asking Buildbucket for the build status
[01:47:30.059] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:30.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:48:0) after 1m0s
[01:48:30.083] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:48:0)
[01:48:30.083] Timer tick, asking Buildbucket for the build status
[01:48:30.175] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:30.175] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:49:0) after 1m0s
[01:49:30.232] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:49:0)
[01:49:30.232] Timer tick, asking Buildbucket for the build status
[01:49:30.294] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:30.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:50:0) after 1m0s
[01:50:30.321] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:50:0)
[01:50:30.321] Timer tick, asking Buildbucket for the build status
[01:50:30.416] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:30.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:51:0) after 1m0s
[01:51:30.439] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:51:0)
[01:51:30.439] Timer tick, asking Buildbucket for the build status
[01:51:30.535] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:30.535] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:52:0) after 1m0s
[01:52:30.555] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:52:0)
[01:52:30.555] Timer tick, asking Buildbucket for the build status
[01:52:30.670] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:30.670] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:53:0) after 1m0s
[01:53:30.852] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:53:0)
[01:53:30.852] Timer tick, asking Buildbucket for the build status
[01:53:31.028] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:31.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:54:0) after 1m0s
[01:54:31.068] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:54:0)
[01:54:31.068] Timer tick, asking Buildbucket for the build status
[01:54:31.125] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:31.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:55:0) after 1m0s
[01:55:31.153] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:55:0)
[01:55:31.153] Timer tick, asking Buildbucket for the build status
[01:55:31.237] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:31.237] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:56:0) after 1m0s
[01:56:31.295] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:56:0)
[01:56:31.295] Timer tick, asking Buildbucket for the build status
[01:56:31.605] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:31.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:57:0) after 1m0s
[01:57:31.608] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:57:0)
[01:57:31.608] Timer tick, asking Buildbucket for the build status
[01:57:31.713] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:31.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:58:0) after 1m0s
[01:58:31.734] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:58:0)
[01:58:31.734] Timer tick, asking Buildbucket for the build status
[01:58:31.802] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:31.802] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:59:0) after 1m0s
[01:59:31.826] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:59:0)
[01:59:31.826] Timer tick, asking Buildbucket for the build status
[01:59:31.899] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:31.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:60:0) after 1m0s
[02:00:31.940] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:60:0)
[02:00:31.940] Timer tick, asking Buildbucket for the build status
[02:00:31.998] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:31.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:61:0) after 1m0s
[02:01:31.973] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:61:0)
[02:01:31.973] Timer tick, asking Buildbucket for the build status
[02:01:32.091] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:32.091] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:62:0) after 1m0s
[02:02:32.119] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:62:0)
[02:02:32.119] Timer tick, asking Buildbucket for the build status
[02:02:32.409] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:32.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:63:0) after 1m0s
[02:03:32.466] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:63:0)
[02:03:32.466] Timer tick, asking Buildbucket for the build status
[02:03:32.573] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:32.573] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:64:0) after 1m0s
[02:04:32.595] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:64:0)
[02:04:32.595] Timer tick, asking Buildbucket for the build status
[02:04:32.682] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:32.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:65:0) after 1m0s
[02:05:32.704] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:65:0)
[02:05:32.704] Timer tick, asking Buildbucket for the build status
[02:05:32.784] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:32.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:66:0) after 1m0s
[02:06:35.031] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:66:0)
[02:06:35.031] Timer tick, asking Buildbucket for the build status
[02:06:35.598] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:35.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:67:0) after 1m0s
[02:07:35.932] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:67:0)
[02:07:35.932] Timer tick, asking Buildbucket for the build status
[02:07:36.223] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:36.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:68:0) after 1m0s
[02:08:36.429] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:68:0)
[02:08:36.429] Timer tick, asking Buildbucket for the build status
[02:08:36.692] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:36.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:69:0) after 1m0s
[02:09:36.910] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:69:0)
[02:09:36.910] Timer tick, asking Buildbucket for the build status
[02:09:36.972] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:36.972] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:70:0) after 1m0s
[02:10:37.222] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:70:0)
[02:10:37.222] Timer tick, asking Buildbucket for the build status
[02:10:37.320] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:37.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:71:0) after 1m0s
[02:11:37.497] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:71:0)
[02:11:37.497] Timer tick, asking Buildbucket for the build status
[02:11:37.580] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:37.580] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:72:0) after 1m0s
[02:12:37.655] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:72:0)
[02:12:37.655] Timer tick, asking Buildbucket for the build status
[02:12:37.821] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:37.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:73:0) after 1m0s
[02:13:37.878] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:73:0)
[02:13:37.878] Timer tick, asking Buildbucket for the build status
[02:13:37.945] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:37.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:74:0) after 1m0s
[02:14:37.984] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:74:0)
[02:14:37.984] Timer tick, asking Buildbucket for the build status
[02:14:38.067] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:38.067] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:75:0) after 1m0s
[02:15:38.136] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:75:0)
[02:15:38.136] Timer tick, asking Buildbucket for the build status
[02:15:38.216] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:38.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:76:0) after 1m0s
[02:16:38.241] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:76:0)
[02:16:38.241] Timer tick, asking Buildbucket for the build status
[02:16:38.342] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:38.342] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:77:0) after 1m0s
[02:17:38.365] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:77:0)
[02:17:38.365] Timer tick, asking Buildbucket for the build status
[02:17:38.478] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:38.478] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:78:0) after 1m0s
[02:18:38.608] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:78:0)
[02:18:38.608] Timer tick, asking Buildbucket for the build status
[02:18:38.679] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:38.679] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:79:0) after 1m0s
[02:19:38.731] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:79:0)
[02:19:38.731] Timer tick, asking Buildbucket for the build status
[02:19:38.871] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:38.871] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:80:0) after 1m0s
[02:20:38.947] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:80:0)
[02:20:38.947] Timer tick, asking Buildbucket for the build status
[02:20:39.137] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:39.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:81:0) after 1m0s
[02:21:39.157] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:81:0)
[02:21:39.157] Timer tick, asking Buildbucket for the build status
[02:21:39.234] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:39.234] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:82:0) after 1m0s
[02:22:39.298] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:82:0)
[02:22:39.298] Timer tick, asking Buildbucket for the build status
[02:22:39.399] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:39.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:83:0) after 1m0s
[02:23:39.432] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:83:0)
[02:23:39.432] Timer tick, asking Buildbucket for the build status
[02:23:39.488] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:39.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:84:0) after 1m0s
[02:24:39.511] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:84:0)
[02:24:39.511] Timer tick, asking Buildbucket for the build status
[02:24:39.578] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:39.578] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:85:0) after 1m0s
[02:25:39.649] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:85:0)
[02:25:39.649] Timer tick, asking Buildbucket for the build status
[02:25:39.718] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:39.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:86:0) after 1m0s
[02:26:39.736] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:86:0)
[02:26:39.736] Timer tick, asking Buildbucket for the build status
[02:26:39.788] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:39.788] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:87:0) after 1m0s
[02:27:39.770] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:87:0)
[02:27:39.770] Timer tick, asking Buildbucket for the build status
[02:27:39.898] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:39.898] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:88:0) after 1m0s
[02:28:40.005] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:88:0)
[02:28:40.005] Timer tick, asking Buildbucket for the build status
[02:28:40.117] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:40.117] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:89:0) after 1m0s
[02:29:40.131] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:89:0)
[02:29:40.131] Timer tick, asking Buildbucket for the build status
[02:29:40.195] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:40.195] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:90:0) after 1m0s
[02:30:40.225] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:90:0)
[02:30:40.225] Timer tick, asking Buildbucket for the build status
[02:30:40.286] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:40.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:91:0) after 1m0s
[02:31:40.319] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:91:0)
[02:31:40.319] Timer tick, asking Buildbucket for the build status
[02:31:40.373] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:40.373] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:92:0) after 1m0s
[02:32:40.425] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:92:0)
[02:32:40.425] Timer tick, asking Buildbucket for the build status
[02:32:40.562] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:40.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:93:0) after 1m0s
[02:33:40.616] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:93:0)
[02:33:40.616] Timer tick, asking Buildbucket for the build status
[02:33:40.674] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:40.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:94:0) after 1m0s
[02:34:40.739] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:94:0)
[02:34:40.739] Timer tick, asking Buildbucket for the build status
[02:34:40.942] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:40.942] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:95:0) after 1m0s
[02:35:40.969] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:95:0)
[02:35:40.969] Timer tick, asking Buildbucket for the build status
[02:35:41.097] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:41.097] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:96:0) after 1m0s
[02:36:41.183] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:96:0)
[02:36:41.183] Timer tick, asking Buildbucket for the build status
[02:36:41.252] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:41.252] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:97:0) after 1m0s
[02:37:41.256] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:97:0)
[02:37:41.256] Timer tick, asking Buildbucket for the build status
[02:37:41.343] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:41.343] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:98:0) after 1m0s
[02:38:41.372] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:98:0)
[02:38:41.372] Timer tick, asking Buildbucket for the build status
[02:38:41.620] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:41.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:99:0) after 1m0s
[02:39:41.706] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:99:0)
[02:39:41.706] Timer tick, asking Buildbucket for the build status
[02:39:41.920] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:41.920] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:100:0) after 1m0s
[02:40:41.946] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:100:0)
[02:40:41.946] Timer tick, asking Buildbucket for the build status
[02:40:42.054] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:42.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:101:0) after 1m0s
[02:41:42.079] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:101:0)
[02:41:42.079] Timer tick, asking Buildbucket for the build status
[02:41:42.482] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:42.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:102:0) after 1m0s
[02:42:42.508] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:102:0)
[02:42:42.508] Timer tick, asking Buildbucket for the build status
[02:42:42.618] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:42.618] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:103:0) after 1m0s
[02:43:43.235] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:103:0)
[02:43:43.235] Timer tick, asking Buildbucket for the build status
[02:43:43.345] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:43.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:104:0) after 1m0s
[02:44:43.451] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:104:0)
[02:44:43.451] Timer tick, asking Buildbucket for the build status
[02:44:43.896] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:43.896] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:105:0) after 1m0s
[02:45:44.175] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:105:0)
[02:45:44.175] Timer tick, asking Buildbucket for the build status
[02:45:44.286] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:44.286] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:106:0) after 1m0s
[02:46:44.683] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:106:0)
[02:46:44.683] Timer tick, asking Buildbucket for the build status
[02:46:45.078] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:45.078] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:107:0) after 1m0s
[02:47:45.163] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:107:0)
[02:47:45.163] Timer tick, asking Buildbucket for the build status
[02:47:45.832] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:45.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:108:0) after 1m0s
[02:48:45.950] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:108:0)
[02:48:45.950] Timer tick, asking Buildbucket for the build status
[02:48:46.029] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:46.029] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:109:0) after 1m0s
[02:49:46.207] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:109:0)
[02:49:46.207] Timer tick, asking Buildbucket for the build status
[02:49:46.329] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:46.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:110:0) after 1m0s
[02:50:46.463] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:110:0)
[02:50:46.463] Timer tick, asking Buildbucket for the build status
[02:50:47.231] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:47.231] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:111:0) after 1m0s
[02:51:47.252] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:111:0)
[02:51:47.252] Timer tick, asking Buildbucket for the build status
[02:51:47.351] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:47.351] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:112:0) after 1m0s
[02:52:47.497] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:112:0)
[02:52:47.497] Timer tick, asking Buildbucket for the build status
[02:52:49.747] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:49.747] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:113:0) after 1m0s
[02:53:49.907] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:113:0)
[02:53:49.907] Timer tick, asking Buildbucket for the build status
[02:53:50.011] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:50.011] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:114:0) after 1m0s
[02:54:50.075] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:114:0)
[02:54:50.075] Timer tick, asking Buildbucket for the build status
[02:54:50.197] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:50.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:115:0) after 1m0s
[02:55:50.229] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:115:0)
[02:55:50.229] Timer tick, asking Buildbucket for the build status
[02:55:50.391] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:50.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:116:0) after 1m0s
[02:56:50.411] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:116:0)
[02:56:50.411] Timer tick, asking Buildbucket for the build status
[02:56:50.506] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:50.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:117:0) after 1m0s
[02:57:50.533] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:117:0)
[02:57:50.533] Timer tick, asking Buildbucket for the build status
[02:57:50.651] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:50.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:118:0) after 1m0s
[02:58:50.675] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:118:0)
[02:58:50.675] Timer tick, asking Buildbucket for the build status
[02:58:50.821] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:50.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:119:0) after 1m0s
[02:59:50.876] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:119:0)
[02:59:50.876] Timer tick, asking Buildbucket for the build status
[02:59:50.962] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:50.962] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:120:0) after 1m0s
[03:00:51.017] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:120:0)
[03:00:51.017] Timer tick, asking Buildbucket for the build status
[03:00:51.138] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:51.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:121:0) after 1m0s
[03:01:51.217] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:121:0)
[03:01:51.217] Timer tick, asking Buildbucket for the build status
[03:01:51.283] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:51.283] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:122:0) after 1m0s
[03:02:51.313] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:122:0)
[03:02:51.313] Timer tick, asking Buildbucket for the build status
[03:02:51.448] Build 8865419506520049136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:51.448] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9030849568693608768:123:0) after 1m0s
[03:03:36.052] Received PubSub notification, asking Buildbucket for the build status
[03:03:36.143] Build 8865419506520049136: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:03:36.143] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603681414503094",
"created_by": "project:chromium",
"created_ts": "1603674134672209",
"id": "8865419506520049136",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"848cbda800711ac828ce256fffa49eaf13b7ef4e\"}}",
"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\": \"848cbda800711ac828ce256fffa49eaf13b7ef4e\", \"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\": 18769, \"got_angle_revision\": \"9e3eec5464d66627144c5fe94f220309158ea2cf\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"848cbda800711ac828ce256fffa49eaf13b7ef4e\", \"got_revision_cp\": \"refs/heads/master@{#820647}\", \"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\": \"848cbda800711ac828ce256fffa49eaf13b7ef4e\", \"swarm_hashes_refs/heads/master(at){#820647}_without_patch\": {\"absl_hardening_tests\": \"64f62512e9f03cbf530bff5711b084547b2ef664\", \"accessibility_unittests\": \"659e1d8881ead7b3c16a119ba449413157999bc6\", \"angle_unittests\": \"c689ddab1381646afc424f3c99eac8ddc9f51610\", \"app_shell_unittests\": \"daabd73d860884471878dd10a608c24d6adf24ad\", \"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\": \"8ff8c49705ff128ad085ca2fa64840a1bc3cc53d\", \"capture_unittests\": \"489221a3a5b5a7581467020cbf62bc289f87f2c6\", \"cast_unittests\": \"521add428123f4bfbbaa89f8be864e3de28e3295\", \"cc_unittests\": \"5eb4e0ab27efe36ab5be4617de59dabd7ad04418\", \"chrome_app_unittests\": \"88933d9646d64dddd4a90f76b7b0dd55ffe3a636\", \"chromedriver_unittests\": \"f11286982b85a03379db1b6bf064bfc73c6121ef\", \"components_browsertests\": \"42eeb71a1981f15ac261e85d8587010c5935d096\", \"components_unittests\": \"54ed9d1d4b8b4fa1044c2fdfb7d8e2f497414eeb\", \"compositor_unittests\": \"4f4b8b366ddfd7774e1d8466b7b4d32c361cc013\", \"content_browsertests\": \"c54850c9dff67d54f8696d1fecbde2f5f2e0dc8c\", \"content_unittests\": \"c1e42e140b611d9dd6bdda7bdf4891c9a87bd417\", \"cronet_tests\": \"8a6906d066bac73fdc0cab61beee5c142ccd5d27\", \"cronet_unittests\": \"6aaef5946e0b40575c7349514f6781966a6d7b2d\", \"crypto_unittests\": \"1fa4a8923d25457a5b0e23a99d4d2bede6a7ceba\", \"dbus_unittests\": \"0182c7b13835f4cce4225d6092d3350a1308b816\", \"device_unittests\": \"7072a2da779517364a65cbb61f4665cefc407692\", \"display_unittests\": \"b083b1ea9576796a2858c957c0909fb1146e195e\", \"events_unittests\": \"5dab2c60f69883b9c6689c441ae2764e2b11d579\", \"extensions_browsertests\": \"41f88d6a9aaa6a635d6030490142cbab01907175\", \"extensions_unittests\": \"d43c9ab6407c3cb195c841f357d506ebfbd6cef5\", \"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\": \"86b2624fe792397e7fc1da1b202b973170f3b5af\", \"headless_unittests\": \"2cf79751216aad25cdb2b8567ece3b357222110d\", \"interactive_ui_tests\": \"31c6ca7c16c1b4cafb6baa3c5299e79b60e3b645\", \"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\": \"801e749cc2c4fde9c6dd712993ec8b171e351a7c\", \"traffic_annotation_auditor_unittests\": \"955e2c3d311b7a44b732e8f58efc6c360097ab94\", \"ui_base_unittests\": \"9befd833d7c9a4674580529bea7f1334901331a8\", \"ui_touch_selection_unittests\": \"71ad941ae43f572ec2acc9619c1fa5c64647670e\", \"unit_tests\": \"3f370848964bcb56a94e6968b89ee73f07d21504\", \"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": "1603674136682834",
"status": "COMPLETED",
"status_changed_ts": "1603681414773642",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/18769",
"builder:Linux CFI",
"buildset:commit/git/848cbda800711ac828ce256fffa49eaf13b7ef4e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/848cbda800711ac828ce256fffa49eaf13b7ef4e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030849568693608768",
"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/8865419506520049136/+/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:4f7b3ee58ee93810",
"user_agent:luci-scheduler"
],
"updated_ts": "1603681414792453",
"url": "https://ci.chromium.org/b/8865419506520049136",
"utcnow_ts": "1603681416133781"
}
}
[03:03:36.143] Invocation finished in 2h1m22.926736579s with status SUCCEEDED