[17:00:06.057] New invocation is queued and will start shortly
[17:00:07.215] Starting the invocation (attempt 1)
[17:00:07.276] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:00:07.281] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:00:07.281] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030698707108930880",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"37be332c3c8c798b454fb289996226ebb6727cf1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9030698707108930880",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/37be332c3c8c798b454fb289996226ebb6727cf1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/37be332c3c8c798b454fb289996226ebb6727cf1",
"gitiles_ref:refs/heads/master"
]
}
[17:00:09.082] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603818007481310",
"id": "8865268644946053680",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"37be332c3c8c798b454fb289996226ebb6727cf1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603818008706906",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21032",
"builder:linux-chromeos-dbg",
"buildset:commit/git/37be332c3c8c798b454fb289996226ebb6727cf1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/37be332c3c8c798b454fb289996226ebb6727cf1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030698707108930880",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865268644946053680/+/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": "1603818008707535",
"url": "https://ci.chromium.org/b/8865268644946053680",
"utcnow_ts": "1603818009065070"
}
}
[17:00:09.082] Task URL: https://ci.chromium.org/b/8865268644946053680
[17:00:09.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:2:0) after 1m0s
[17:01:09.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:2:0)
[17:01:09.161] Timer tick, asking Buildbucket for the build status
[17:01:09.288] Build 8865268644946053680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:01:09.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:3:0) after 1m0s
[17:01:35.857] Received PubSub notification, asking Buildbucket for the build status
[17:01:36.158] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:09.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:3:0)
[17:02:09.326] Timer tick, asking Buildbucket for the build status
[17:02:09.466] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:09.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:5:0) after 1m0s
[17:03:09.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:5:0)
[17:03:09.467] Timer tick, asking Buildbucket for the build status
[17:03:09.673] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:09.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:6:0) after 1m0s
[17:04:09.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:6:0)
[17:04:09.723] Timer tick, asking Buildbucket for the build status
[17:04:09.782] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:09.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:7:0) after 1m0s
[17:05:09.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:7:0)
[17:05:09.813] Timer tick, asking Buildbucket for the build status
[17:05:09.930] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:09.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:8:0) after 1m0s
[17:06:09.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:8:0)
[17:06:09.974] Timer tick, asking Buildbucket for the build status
[17:06:10.274] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:10.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:9:0) after 1m0s
[17:07:10.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:9:0)
[17:07:10.467] Timer tick, asking Buildbucket for the build status
[17:07:10.725] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:10.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:10:0) after 1m0s
[17:08:10.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:10:0)
[17:08:10.771] Timer tick, asking Buildbucket for the build status
[17:08:10.981] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:10.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:11:0) after 1m0s
[17:09:11.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:11:0)
[17:09:11.036] Timer tick, asking Buildbucket for the build status
[17:09:11.180] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:11.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:12:0) after 1m0s
[17:10:11.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:12:0)
[17:10:11.192] Timer tick, asking Buildbucket for the build status
[17:10:11.555] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:11.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:13:0) after 1m0s
[17:11:11.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:13:0)
[17:11:11.606] Timer tick, asking Buildbucket for the build status
[17:11:11.957] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:11.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:14:0) after 1m0s
[17:12:12.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:14:0)
[17:12:12.034] Timer tick, asking Buildbucket for the build status
[17:12:12.199] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:12.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:15:0) after 1m0s
[17:13:12.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:15:0)
[17:13:12.260] Timer tick, asking Buildbucket for the build status
[17:13:12.425] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:12.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:16:0) after 1m0s
[17:14:12.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:16:0)
[17:14:12.456] Timer tick, asking Buildbucket for the build status
[17:14:12.778] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:12.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:17:0) after 1m0s
[17:15:12.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:17:0)
[17:15:12.849] Timer tick, asking Buildbucket for the build status
[17:15:12.949] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:12.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:18:0) after 1m0s
[17:16:13.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:18:0)
[17:16:13.049] Timer tick, asking Buildbucket for the build status
[17:16:13.131] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:13.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:19:0) after 1m0s
[17:17:13.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:19:0)
[17:17:13.224] Timer tick, asking Buildbucket for the build status
[17:17:13.321] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:13.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:20:0) after 1m0s
[17:18:13.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:20:0)
[17:18:13.413] Timer tick, asking Buildbucket for the build status
[17:18:13.537] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:13.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:21:0) after 1m0s
[17:19:13.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:21:0)
[17:19:13.608] Timer tick, asking Buildbucket for the build status
[17:19:13.720] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:13.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:22:0) after 1m0s
[17:20:13.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:22:0)
[17:20:13.866] Timer tick, asking Buildbucket for the build status
[17:20:14.310] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:14.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:23:0) after 1m0s
[17:21:14.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:23:0)
[17:21:14.386] Timer tick, asking Buildbucket for the build status
[17:21:14.453] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:14.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:24:0) after 1m0s
[17:22:14.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:24:0)
[17:22:14.508] Timer tick, asking Buildbucket for the build status
[17:22:14.597] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:14.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:25:0) after 1m0s
[17:23:14.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:25:0)
[17:23:14.774] Timer tick, asking Buildbucket for the build status
[17:23:14.839] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:14.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:26:0) after 1m0s
[17:24:14.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:26:0)
[17:24:14.933] Timer tick, asking Buildbucket for the build status
[17:24:15.015] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:15.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:27:0) after 1m0s
[17:25:15.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:27:0)
[17:25:15.392] Timer tick, asking Buildbucket for the build status
[17:25:15.504] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:15.504] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:28:0) after 1m0s
[17:26:15.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:28:0)
[17:26:15.774] Timer tick, asking Buildbucket for the build status
[17:26:16.298] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:16.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:29:0) after 1m0s
[17:27:16.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:29:0)
[17:27:16.806] Timer tick, asking Buildbucket for the build status
[17:27:16.890] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:16.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:30:0) after 1m0s
[17:28:17.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:30:0)
[17:28:17.084] Timer tick, asking Buildbucket for the build status
[17:28:17.160] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:17.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:31:0) after 1m0s
[17:29:17.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:31:0)
[17:29:17.314] Timer tick, asking Buildbucket for the build status
[17:29:17.377] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:17.377] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:32:0) after 1m0s
[17:30:17.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:32:0)
[17:30:17.461] Timer tick, asking Buildbucket for the build status
[17:30:17.605] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:17.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:33:0) after 1m0s
[17:31:17.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:33:0)
[17:31:17.627] Timer tick, asking Buildbucket for the build status
[17:31:17.767] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:17.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:34:0) after 1m0s
[17:32:17.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:34:0)
[17:32:17.756] Timer tick, asking Buildbucket for the build status
[17:32:17.997] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:17.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:35:0) after 1m0s
[17:33:18.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:35:0)
[17:33:18.056] Timer tick, asking Buildbucket for the build status
[17:33:18.147] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:18.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:36:0) after 1m0s
[17:34:18.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:36:0)
[17:34:18.228] Timer tick, asking Buildbucket for the build status
[17:34:18.528] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:18.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:37:0) after 1m0s
[17:35:18.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:37:0)
[17:35:18.607] Timer tick, asking Buildbucket for the build status
[17:35:18.785] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:18.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:38:0) after 1m0s
[17:36:18.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:38:0)
[17:36:18.937] Timer tick, asking Buildbucket for the build status
[17:36:19.079] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:19.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:39:0) after 1m0s
[17:37:19.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:39:0)
[17:37:19.152] Timer tick, asking Buildbucket for the build status
[17:37:19.238] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:19.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:40:0) after 1m0s
[17:38:19.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:40:0)
[17:38:19.265] Timer tick, asking Buildbucket for the build status
[17:38:22.791] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:22.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:41:0) after 1m0s
[17:39:22.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:41:0)
[17:39:22.911] Timer tick, asking Buildbucket for the build status
[17:39:23.009] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:23.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:42:0) after 1m0s
[17:40:23.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:42:0)
[17:40:23.143] Timer tick, asking Buildbucket for the build status
[17:40:23.334] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:23.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:43:0) after 1m0s
[17:41:23.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:43:0)
[17:41:23.494] Timer tick, asking Buildbucket for the build status
[17:41:23.701] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:23.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:44:0) after 1m0s
[17:42:23.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:44:0)
[17:42:23.892] Timer tick, asking Buildbucket for the build status
[17:42:23.965] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:23.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:45:0) after 1m0s
[17:43:24.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:45:0)
[17:43:24.314] Timer tick, asking Buildbucket for the build status
[17:43:24.549] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:24.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:46:0) after 1m0s
[17:44:24.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:46:0)
[17:44:24.611] Timer tick, asking Buildbucket for the build status
[17:44:24.758] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:24.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:47:0) after 1m0s
[17:45:24.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:47:0)
[17:45:24.978] Timer tick, asking Buildbucket for the build status
[17:45:25.167] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:25.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:48:0) after 1m0s
[17:46:25.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:48:0)
[17:46:25.345] Timer tick, asking Buildbucket for the build status
[17:46:25.450] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:25.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:49:0) after 1m0s
[17:47:25.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:49:0)
[17:47:25.736] Timer tick, asking Buildbucket for the build status
[17:47:25.828] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:25.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:50:0) after 1m0s
[17:48:25.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:50:0)
[17:48:25.911] Timer tick, asking Buildbucket for the build status
[17:48:25.998] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:25.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:51:0) after 1m0s
[17:49:26.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:51:0)
[17:49:26.053] Timer tick, asking Buildbucket for the build status
[17:49:26.644] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:26.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:52:0) after 1m0s
[17:50:26.777] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:52:0)
[17:50:26.777] Timer tick, asking Buildbucket for the build status
[17:50:28.265] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:28.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:53:0) after 1m0s
[17:51:28.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:53:0)
[17:51:28.417] Timer tick, asking Buildbucket for the build status
[17:51:28.599] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:28.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:54:0) after 1m0s
[17:52:28.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:54:0)
[17:52:28.761] Timer tick, asking Buildbucket for the build status
[17:52:28.981] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:28.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:55:0) after 1m0s
[17:53:29.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:55:0)
[17:53:29.011] Timer tick, asking Buildbucket for the build status
[17:53:29.429] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:29.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:56:0) after 1m0s
[17:54:29.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:56:0)
[17:54:29.486] Timer tick, asking Buildbucket for the build status
[17:54:30.268] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:30.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:57:0) after 1m0s
[17:55:30.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:57:0)
[17:55:30.382] Timer tick, asking Buildbucket for the build status
[17:55:30.537] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:30.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:58:0) after 1m0s
[17:56:30.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:58:0)
[17:56:30.583] Timer tick, asking Buildbucket for the build status
[17:56:30.765] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:30.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:59:0) after 1m0s
[17:57:30.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:59:0)
[17:57:30.821] Timer tick, asking Buildbucket for the build status
[17:57:31.012] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:31.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:60:0) after 1m0s
[17:58:31.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:60:0)
[17:58:31.046] Timer tick, asking Buildbucket for the build status
[17:58:31.133] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:31.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:61:0) after 1m0s
[17:59:31.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:61:0)
[17:59:31.197] Timer tick, asking Buildbucket for the build status
[17:59:31.649] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:31.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:62:0) after 1m0s
[18:00:31.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:62:0)
[18:00:31.727] Timer tick, asking Buildbucket for the build status
[18:00:33.650] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:33.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:63:0) after 1m0s
[18:01:33.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:63:0)
[18:01:33.713] Timer tick, asking Buildbucket for the build status
[18:01:33.861] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:33.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:64:0) after 1m0s
[18:02:33.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:64:0)
[18:02:33.894] Timer tick, asking Buildbucket for the build status
[18:02:34.089] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:34.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:65:0) after 1m0s
[18:03:34.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:65:0)
[18:03:34.147] Timer tick, asking Buildbucket for the build status
[18:03:34.514] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:34.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:66:0) after 1m0s
[18:04:34.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:66:0)
[18:04:34.603] Timer tick, asking Buildbucket for the build status
[18:04:34.723] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:34.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:67:0) after 1m0s
[18:05:34.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:67:0)
[18:05:34.894] Timer tick, asking Buildbucket for the build status
[18:05:35.064] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:35.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:68:0) after 1m0s
[18:06:35.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:68:0)
[18:06:35.138] Timer tick, asking Buildbucket for the build status
[18:06:35.382] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:35.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:69:0) after 1m0s
[18:07:35.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:69:0)
[18:07:35.431] Timer tick, asking Buildbucket for the build status
[18:07:35.545] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:35.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:70:0) after 1m0s
[18:08:35.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:70:0)
[18:08:35.599] Timer tick, asking Buildbucket for the build status
[18:08:36.030] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:36.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:71:0) after 1m0s
[18:09:36.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:71:0)
[18:09:36.083] Timer tick, asking Buildbucket for the build status
[18:09:36.160] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:36.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:72:0) after 1m0s
[18:10:36.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:72:0)
[18:10:36.190] Timer tick, asking Buildbucket for the build status
[18:10:36.345] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:36.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:73:0) after 1m0s
[18:11:36.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:73:0)
[18:11:36.330] Timer tick, asking Buildbucket for the build status
[18:11:36.629] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:36.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:74:0) after 1m0s
[18:12:36.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:74:0)
[18:12:36.702] Timer tick, asking Buildbucket for the build status
[18:12:37.023] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:37.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:75:0) after 1m0s
[18:13:37.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:75:0)
[18:13:37.116] Timer tick, asking Buildbucket for the build status
[18:13:37.268] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:37.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:76:0) after 1m0s
[18:14:37.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:76:0)
[18:14:37.435] Timer tick, asking Buildbucket for the build status
[18:14:37.592] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:37.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:77:0) after 1m0s
[18:15:37.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:77:0)
[18:15:37.656] Timer tick, asking Buildbucket for the build status
[18:15:37.911] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:37.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:78:0) after 1m0s
[18:16:37.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:78:0)
[18:16:37.957] Timer tick, asking Buildbucket for the build status
[18:16:38.059] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:38.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:79:0) after 1m0s
[18:17:38.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:79:0)
[18:17:38.142] Timer tick, asking Buildbucket for the build status
[18:17:38.737] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:38.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:80:0) after 1m0s
[18:18:38.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:80:0)
[18:18:38.810] Timer tick, asking Buildbucket for the build status
[18:18:38.895] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:38.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:81:0) after 1m0s
[18:19:38.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:81:0)
[18:19:38.906] Timer tick, asking Buildbucket for the build status
[18:19:39.024] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:39.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:82:0) after 1m0s
[18:20:39.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:82:0)
[18:20:39.064] Timer tick, asking Buildbucket for the build status
[18:20:39.205] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:39.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:83:0) after 1m0s
[18:21:39.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:83:0)
[18:21:39.238] Timer tick, asking Buildbucket for the build status
[18:21:39.318] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:39.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:84:0) after 1m0s
[18:22:39.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:84:0)
[18:22:39.382] Timer tick, asking Buildbucket for the build status
[18:22:39.816] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:39.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:85:0) after 1m0s
[18:23:39.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:85:0)
[18:23:39.940] Timer tick, asking Buildbucket for the build status
[18:23:40.073] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:40.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:86:0) after 1m0s
[18:24:40.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:86:0)
[18:24:40.177] Timer tick, asking Buildbucket for the build status
[18:24:40.516] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:40.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:87:0) after 1m0s
[18:25:40.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:87:0)
[18:25:40.573] Timer tick, asking Buildbucket for the build status
[18:25:40.974] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:40.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:88:0) after 1m0s
[18:26:41.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:88:0)
[18:26:41.052] Timer tick, asking Buildbucket for the build status
[18:26:41.428] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:41.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:89:0) after 1m0s
[18:27:41.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:89:0)
[18:27:41.467] Timer tick, asking Buildbucket for the build status
[18:27:41.564] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:41.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:90:0) after 1m0s
[18:28:41.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:90:0)
[18:28:41.660] Timer tick, asking Buildbucket for the build status
[18:28:41.779] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:41.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:91:0) after 1m0s
[18:29:41.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:91:0)
[18:29:41.826] Timer tick, asking Buildbucket for the build status
[18:29:41.921] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:41.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:92:0) after 1m0s
[18:30:42.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:92:0)
[18:30:42.012] Timer tick, asking Buildbucket for the build status
[18:30:42.160] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:42.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:93:0) after 1m0s
[18:31:42.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:93:0)
[18:31:42.394] Timer tick, asking Buildbucket for the build status
[18:31:42.742] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:42.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:94:0) after 1m0s
[18:32:42.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:94:0)
[18:32:42.889] Timer tick, asking Buildbucket for the build status
[18:32:43.076] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:43.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:95:0) after 1m0s
[18:33:43.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:95:0)
[18:33:43.150] Timer tick, asking Buildbucket for the build status
[18:33:43.709] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:43.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:96:0) after 1m0s
[18:34:43.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:96:0)
[18:34:43.819] Timer tick, asking Buildbucket for the build status
[18:34:43.928] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:43.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:97:0) after 1m0s
[18:35:44.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:97:0)
[18:35:44.066] Timer tick, asking Buildbucket for the build status
[18:35:44.198] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:44.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:98:0) after 1m0s
[18:36:44.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:98:0)
[18:36:44.317] Timer tick, asking Buildbucket for the build status
[18:36:44.435] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:44.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:99:0) after 1m0s
[18:37:44.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:99:0)
[18:37:44.691] Timer tick, asking Buildbucket for the build status
[18:37:45.409] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:45.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:100:0) after 1m0s
[18:38:45.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:100:0)
[18:38:45.542] Timer tick, asking Buildbucket for the build status
[18:38:45.874] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:45.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:101:0) after 1m0s
[18:39:45.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:101:0)
[18:39:45.885] Timer tick, asking Buildbucket for the build status
[18:39:46.594] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:46.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:102:0) after 1m0s
[18:40:46.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:102:0)
[18:40:46.656] Timer tick, asking Buildbucket for the build status
[18:40:47.026] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:47.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:103:0) after 1m0s
[18:41:47.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:103:0)
[18:41:47.153] Timer tick, asking Buildbucket for the build status
[18:41:47.298] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:47.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:104:0) after 1m0s
[18:42:47.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:104:0)
[18:42:47.359] Timer tick, asking Buildbucket for the build status
[18:42:47.493] Build 8865268644946053680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:47.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030698707108930880:105:0) after 1m0s
[18:43:28.616] Received PubSub notification, asking Buildbucket for the build status
[18:43:28.743] Build 8865268644946053680: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:43:28.743] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603824207086491",
"created_by": "project:chromium",
"created_ts": "1603818007481310",
"id": "8865268644946053680",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"37be332c3c8c798b454fb289996226ebb6727cf1\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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\": \"37be332c3c8c798b454fb289996226ebb6727cf1\", \"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-us-east1-d-8-33-tkqx\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21032, \"got_angle_revision\": \"b5ba693316fdd5e680f2bb4cf1a2f9bed589d8e2\", \"got_dawn_revision\": \"25eeaa3d39afcc82fe9d384949d4e9c99e6e7903\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"37be332c3c8c798b454fb289996226ebb6727cf1\", \"got_revision_cp\": \"refs/heads/master@{#821295}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"47c8f45b3d543bcc13f3f74d6c335f10908a5947\", \"got_v8_revision_cp\": \"refs/heads/8.8.188@{#1}\", \"got_webrtc_revision\": \"0fb0eb3e80c09e0483c4dccdaa472e7e81f182fe\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32491}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"37be332c3c8c798b454fb289996226ebb6727cf1\", \"swarm_hashes_refs/heads/master(at){#821295}_without_patch\": {\"absl_hardening_tests\": \"d1117709b13225757e913dbb29174f9aee9b1341\", \"accessibility_unittests\": \"2545cf68e14f8bd946d36f61a810f48b3819ba38\", \"angle_unittests\": \"d7d4eb23d392751e3ebe6f17f85b7db8514c3ec5\", \"app_list_unittests\": \"5b212476b2d763c785c4acf5ec4733865cb31033\", \"app_shell_unittests\": \"67390aa35f98389a0624d0273f7c5c625840734a\", \"ash_unittests\": \"cbb9ccf75c8bf4d4fe47a4c16567208f1db5ce6e\", \"aura_unittests\": \"9a077b7fa008275d5157dfd0eb72cc16952d8000\", \"base_unittests\": \"cf77740b5e6270b3b17c4bcda2fa78d0be3e3ad5\", \"base_util_unittests\": \"ee3551083ebee25d93215c5feade14a552065d4e\", \"blink_common_unittests\": \"b8e3d7bbedffc9f73017c168fddf482de5009c9f\", \"blink_fuzzer_unittests\": \"cee5356216bc207decfbcaf594ae0a0e8e62d5b4\", \"blink_heap_unittests\": \"08ae2c4a92d6002a9544e7cda9a705dcdb8d7208\", \"blink_platform_unittests\": \"f501a38c70b0bcdf48a7cf5ba54e39292d06eb58\", \"blink_unittests\": \"4bd915a451d1f49efab3c42a2ee7e1de3ff53cf7\", \"boringssl_crypto_tests\": \"b492de00115fdc4536a9f642cd15b42ab7d25d7f\", \"boringssl_ssl_tests\": \"9f2a10e2e19b24964493e041a77c2729d1ed887d\", \"browser_tests\": \"0a9e0b3790614dc752d0e2782c760b268bbdfa88\", \"capture_unittests\": \"6e55472069fa995f610ef96a183b34602502d089\", \"cast_unittests\": \"91f865201d618ba23dcc6dd514d7fcc716316a6b\", \"cc_unittests\": \"43da2ed19147eb87c41a1007eff608b30850d306\", \"chrome_app_unittests\": \"6d8b8fc7c9e6551de1da5fa22cea459709178947\", \"chromedriver_unittests\": \"6edcf0cc16fc461d25f309b557d89f85cd080114\", \"chromeos_components_unittests\": \"d1dda79264f9df62563a180f19cf6c337a9bafb5\", \"chromeos_unittests\": \"c305930bd366b06bc56e0f704a3183faeddf953b\", \"components_browsertests\": \"48ed551d848ed1c104e01e77652e503bea164d21\", \"components_unittests\": \"2a7d2a1ec5e1e43c18e35fd60c7211fbaa369bbe\", \"compositor_unittests\": \"fd1aa66a4137aca76bfcdba35f0bc4cd02168f09\", \"content_browsertests\": \"489fd421e43c4c426d153d94a2bca776b9266789\", \"content_unittests\": \"7a84d15409f97d2ed1333bb3abf7c1d540077332\", \"crypto_unittests\": \"0a872cc91350d85b34ff9a658dd5fec5bd5dcf2d\", \"dbus_unittests\": \"69afcab57e4dd690fcdfcb3598914d1899d2a1bd\", \"device_unittests\": \"0a3dbfb0c44dd43a2191e5ccc8559b262fbb4e17\", \"display_unittests\": \"6edbdc05b099d5400ae87046ddcb08bc2925c2b9\", \"events_unittests\": \"f5156e4ad5ee0bb46dad39e40c72198810eef7ed\", \"exo_unittests\": \"1094b3d0ee08f4b618e96bdc326dfe008c3078c4\", \"extensions_browsertests\": \"8ed273063cfa89b8df062f1c9ed27cf665b4386c\", \"extensions_unittests\": \"870d95d53f8bfdb330bdd076b2495a982fbd48bb\", \"filesystem_service_unittests\": \"1cd7492d72c24837107404ac72c35553aa03599c\", \"gcm_unit_tests\": \"a1e20eb7c846054a353868ddd989c10ab3f1efde\", \"gfx_unittests\": \"f50713134cc563e3a89faf7b2969dcba01e40454\", \"gin_unittests\": \"5dca2cc4ed186d69bcf40503b2190857ffdf8358\", \"gl_unittests_ozone\": \"7d0b8b4ff9481ca4d82fbd246e0e99b2cc7bcfe3\", \"google_apis_unittests\": \"e629969f1992211844a2be3c13ed3b7eb5b512a9\", \"gpu_unittests\": \"097b32e114c196d6b64640377bebd4d5c00a2578\", \"gwp_asan_unittests\": \"5f7b8e98caf56039e8a57aaf4a9f25388deae50c\", \"interactive_ui_tests\": \"f2744eae6ffd2b1f97be21238fe6e8a8f6daaa8a\", \"ipc_tests\": \"3b14bbd29c81be451413d4cf11b9e3e813c1c26d\", \"jingle_unittests\": \"487d1f152fbb164a6920af5b240c8d0f52ce7354\", \"keyboard_unittests\": \"60510d6782b27ac9a841b80c5001bfe2b10eed68\", \"latency_unittests\": \"9e5a029657454cecbe07f8f9fe1de0845342b8d8\", \"libjingle_xmpp_unittests\": \"cda6c8e3125f7975a649f34a82459c9ecc79b277\", \"media_blink_unittests\": \"2eb94b502f75b4beb4c49d53cc186653f4750894\", \"media_unittests\": \"68c396ef8dc52b31f30ce33ebacf62001fee12f0\", \"message_center_unittests\": \"cbbc4a957118540a67d46fbe063c61284e78f9d5\", \"midi_unittests\": \"32edd5e79a169ce882b58e35caa3626c1721c121\", \"mojo_core_unittests\": \"f04387528f2b0434cd09e89abf9eb70a1a92c3eb\", \"mojo_unittests\": \"c041b97fe0e95184c6e978aa8482b78666059d82\", \"nacl_helper_nonsfi_unittests\": \"6a5bcd604d6fb68aeb5f4b27161869db4f5d3e22\", \"nacl_loader_unittests\": \"0e7f94be195fc7af0335c483c927dcd153e126c8\", \"native_theme_unittests\": \"00d3dfc2356ddf09803aad03345f80ff448d9366\", \"net_unittests\": \"4085e668c03bf11c014d0e6cad08c898bae505a6\", \"ozone_gl_unittests\": \"04e38f805e3b9a23add3987d9f7ee4e5e8cfd0e3\", \"ozone_unittests\": \"e0f2c4cde150f53f405416f985209951923285f2\", \"ozone_x11_unittests\": \"3b23eef846fef55144c96c9a0fcd956ba2ef5f02\", \"pdf_unittests\": \"0563038655f75b680926ba57216cf8970b8f7150\", \"perfetto_unittests\": \"4f43664cdb0e8c35289365b79f07416ba3146382\", \"ppapi_unittests\": \"3d7ee46f4e8604f18abac7c5368f4db5028a8687\", \"printing_unittests\": \"321a74bae2a0faca5b4b7c021ebd9bf6d9a6b8d8\", \"remoting_unittests\": \"266b14b54e8db3abc2a75a73002c17c58c32995c\", \"sandbox_linux_unittests\": \"e5993c9843a8293fe870380543eeb4a17dd784a0\", \"service_manager_unittests\": \"80570e8ad0ccb59c64c767a856124ba216271b4c\", \"services_unittests\": \"19d331e797eca6c115086b72da6a5646716b3621\", \"shell_dialogs_unittests\": \"dc43b928db666e468683727748426dee41175a73\", \"skia_unittests\": \"c31d44009671d7681811327f8288c92ff65221d3\", \"snapshot_unittests\": \"54469be8064a827fb89d7f20dfa57e07b3a53451\", \"sql_unittests\": \"f3e5177d235abd345fcfb90f0104fca0a33c5995\", \"storage_unittests\": \"6db67a5a502257717224eef0ed8905dbbf8cef34\", \"sync_integration_tests\": \"1e15a6defa8ea17120667ca954107179e6290d10\", \"traffic_annotation_auditor_unittests\": \"c48eae4f37869ffd3749411826ee5228dcd0b255\", \"ui_base_unittests\": \"24f5ae9ca3b2cc9b6990d28f98e39528ccb2a702\", \"ui_chromeos_unittests\": \"99bbaddcdab21719bd4dfad77668d709754b3e94\", \"ui_touch_selection_unittests\": \"f44702b61bb927d0e8c88418d723f881adcc0383\", \"unit_tests\": \"df7d57bc1e8df1122762f9c912e22205b636372f\", \"url_unittests\": \"7b7be70b35ee487503bb93fdaa370bf0666d1538\", \"usage_time_limit_unittests\": \"f96649ada5b2561378b66fb483f28c265825ef34\", \"views_unittests\": \"07382b7cfca1033779456b8c888f236d9ca71dc3\", \"viz_unittests\": \"3453810afb56a8b44372e6190114f4c5c5b2b4f7\", \"wm_unittests\": \"48e6134ab71cdefa346595da571e70c4c6fdf981\", \"wtf_unittests\": \"1e159b93e0c1c984e9da4edf1bc691804654c5c8\", \"zlib_unittests\": \"8538901a6f246991c0636b9909ba0117bf0fdc80\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_08506e22a0e0fdc29bd318165699b599f0671cf91287ea7a96642b02d7ff24e4_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_78c5fa2a76d0a7a104d66f8a40d0b5b0500192b052ec21dd345993f3fb5ca43a_v2\", \"builder_8e7ad9a10a7772feba5b42dda56992e918fe88f23579c3ddaf696dde66ee4238_v2\", \"builder_c9091f6bc58db7983401393b6dacc93b3db8fae2c2ae9b40177b9e0904c8bc80_v2\", \"builder_dd549fc6a716e6a939fbd3a419c5738d31929c905615e3b6decc21ab2a48e41b_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-33-tkqx\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5613-2fddb4d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603818094456706",
"status": "COMPLETED",
"status_changed_ts": "1603824207584877",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21032",
"builder:linux-chromeos-dbg",
"buildset:commit/git/37be332c3c8c798b454fb289996226ebb6727cf1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/37be332c3c8c798b454fb289996226ebb6727cf1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030698707108930880",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8865268644946053680/+/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:4f83d23ada8b5c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603824207682281",
"url": "https://ci.chromium.org/b/8865268644946053680",
"utcnow_ts": "1603824208734887"
}
}
[18:43:28.743] Invocation finished in 1h43m22.707907809s with status SUCCEEDED