[14:43:26.551] New invocation is queued and will start shortly
[14:43:27.645] Starting the invocation (attempt 1)
[14:43:27.689] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:43:27.689] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:43:27.689] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024184323326305584",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"807acce36a4baa1004d23ae896b07e2148ea1533\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9024184323326305584",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/807acce36a4baa1004d23ae896b07e2148ea1533",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/807acce36a4baa1004d23ae896b07e2148ea1533",
"gitiles_ref:refs/heads/master"
]
}
[14:43:28.298] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610030607768400",
"id": "8858754261387577920",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"807acce36a4baa1004d23ae896b07e2148ea1533\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610030608183037",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22101",
"builder:linux-chromeos-dbg",
"buildset:commit/git/807acce36a4baa1004d23ae896b07e2148ea1533",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/807acce36a4baa1004d23ae896b07e2148ea1533",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024184323326305584",
"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/8858754261387577920/+/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": "1610030608183194",
"url": "https://ci.chromium.org/b/8858754261387577920",
"utcnow_ts": "1610030608290577"
}
}
[14:43:28.298] Task URL: https://ci.chromium.org/b/8858754261387577920
[14:43:28.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:2:0) after 1m0s
[14:43:30.277] Received PubSub notification, asking Buildbucket for the build status
[14:43:30.356] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:28.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:2:0)
[14:44:28.440] Timer tick, asking Buildbucket for the build status
[14:44:28.551] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:28.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:4:0) after 1m0s
[14:45:28.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:4:0)
[14:45:28.724] Timer tick, asking Buildbucket for the build status
[14:45:28.785] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:28.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:5:0) after 1m0s
[14:46:28.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:5:0)
[14:46:28.942] Timer tick, asking Buildbucket for the build status
[14:46:29.069] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:29.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:6:0) after 1m0s
[14:47:29.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:6:0)
[14:47:29.285] Timer tick, asking Buildbucket for the build status
[14:47:29.497] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:29.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:7:0) after 1m0s
[14:48:29.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:7:0)
[14:48:29.533] Timer tick, asking Buildbucket for the build status
[14:48:29.618] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:29.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:8:0) after 1m0s
[14:49:29.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:8:0)
[14:49:29.706] Timer tick, asking Buildbucket for the build status
[14:49:29.974] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:29.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:9:0) after 1m0s
[14:50:30.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:9:0)
[14:50:30.078] Timer tick, asking Buildbucket for the build status
[14:50:30.405] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:30.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:10:0) after 1m0s
[14:51:30.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:10:0)
[14:51:30.442] Timer tick, asking Buildbucket for the build status
[14:51:30.594] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:30.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:11:0) after 1m0s
[14:52:30.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:11:0)
[14:52:30.609] Timer tick, asking Buildbucket for the build status
[14:52:31.442] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:31.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:12:0) after 1m0s
[14:53:31.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:12:0)
[14:53:31.542] Timer tick, asking Buildbucket for the build status
[14:53:32.103] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:32.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:13:0) after 1m0s
[14:54:32.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:13:0)
[14:54:32.249] Timer tick, asking Buildbucket for the build status
[14:54:32.308] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:32.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:14:0) after 1m0s
[14:55:32.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:14:0)
[14:55:32.328] Timer tick, asking Buildbucket for the build status
[14:55:32.557] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:32.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:15:0) after 1m0s
[14:56:32.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:15:0)
[14:56:32.605] Timer tick, asking Buildbucket for the build status
[14:56:32.824] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:32.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:16:0) after 1m0s
[14:57:32.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:16:0)
[14:57:32.874] Timer tick, asking Buildbucket for the build status
[14:57:33.022] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:33.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:17:0) after 1m0s
[14:58:33.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:17:0)
[14:58:33.037] Timer tick, asking Buildbucket for the build status
[14:58:33.153] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:33.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:18:0) after 1m0s
[14:59:33.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:18:0)
[14:59:33.205] Timer tick, asking Buildbucket for the build status
[14:59:33.273] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:33.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:19:0) after 1m0s
[15:00:33.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:19:0)
[15:00:33.399] Timer tick, asking Buildbucket for the build status
[15:00:33.466] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:33.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:20:0) after 1m0s
[15:01:33.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:20:0)
[15:01:33.558] Timer tick, asking Buildbucket for the build status
[15:01:33.639] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:33.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:21:0) after 1m0s
[15:02:33.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:21:0)
[15:02:33.711] Timer tick, asking Buildbucket for the build status
[15:02:33.778] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:33.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:22:0) after 1m0s
[15:03:33.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:22:0)
[15:03:33.760] Timer tick, asking Buildbucket for the build status
[15:03:33.883] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:33.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:23:0) after 1m0s
[15:04:33.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:23:0)
[15:04:33.931] Timer tick, asking Buildbucket for the build status
[15:04:34.115] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:34.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:24:0) after 1m0s
[15:05:34.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:24:0)
[15:05:34.122] Timer tick, asking Buildbucket for the build status
[15:05:34.203] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:34.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:25:0) after 1m0s
[15:06:34.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:25:0)
[15:06:34.299] Timer tick, asking Buildbucket for the build status
[15:06:34.380] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:34.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:26:0) after 1m0s
[15:07:34.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:26:0)
[15:07:34.668] Timer tick, asking Buildbucket for the build status
[15:07:34.806] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:34.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:27:0) after 1m0s
[15:08:34.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:27:0)
[15:08:34.903] Timer tick, asking Buildbucket for the build status
[15:08:35.039] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:35.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:28:0) after 1m0s
[15:09:35.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:28:0)
[15:09:35.052] Timer tick, asking Buildbucket for the build status
[15:09:35.189] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:35.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:29:0) after 1m0s
[15:10:35.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:29:0)
[15:10:35.195] Timer tick, asking Buildbucket for the build status
[15:10:35.336] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:35.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:30:0) after 1m0s
[15:11:35.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:30:0)
[15:11:35.424] Timer tick, asking Buildbucket for the build status
[15:11:35.506] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:35.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:31:0) after 1m0s
[15:12:35.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:31:0)
[15:12:35.704] Timer tick, asking Buildbucket for the build status
[15:12:36.086] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:36.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:32:0) after 1m0s
[15:13:36.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:32:0)
[15:13:36.199] Timer tick, asking Buildbucket for the build status
[15:13:36.372] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:36.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:33:0) after 1m0s
[15:14:36.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:33:0)
[15:14:36.408] Timer tick, asking Buildbucket for the build status
[15:14:36.498] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:36.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:34:0) after 1m0s
[15:15:36.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:34:0)
[15:15:36.616] Timer tick, asking Buildbucket for the build status
[15:15:36.685] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:36.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:35:0) after 1m0s
[15:16:36.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:35:0)
[15:16:36.670] Timer tick, asking Buildbucket for the build status
[15:16:36.778] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:36.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:36:0) after 1m0s
[15:17:36.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:36:0)
[15:17:36.860] Timer tick, asking Buildbucket for the build status
[15:17:36.982] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:36.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:37:0) after 1m0s
[15:18:37.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:37:0)
[15:18:37.011] Timer tick, asking Buildbucket for the build status
[15:18:37.136] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:37.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:38:0) after 1m0s
[15:19:37.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:38:0)
[15:19:37.205] Timer tick, asking Buildbucket for the build status
[15:19:37.287] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:37.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:39:0) after 1m0s
[15:20:37.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:39:0)
[15:20:37.375] Timer tick, asking Buildbucket for the build status
[15:20:37.434] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:37.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:40:0) after 1m0s
[15:21:37.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:40:0)
[15:21:37.634] Timer tick, asking Buildbucket for the build status
[15:21:37.884] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:37.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:41:0) after 1m0s
[15:22:37.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:41:0)
[15:22:37.910] Timer tick, asking Buildbucket for the build status
[15:22:38.073] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:38.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:42:0) after 1m0s
[15:23:38.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:42:0)
[15:23:38.168] Timer tick, asking Buildbucket for the build status
[15:23:38.306] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:38.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:43:0) after 1m0s
[15:24:38.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:43:0)
[15:24:38.574] Timer tick, asking Buildbucket for the build status
[15:24:39.154] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:39.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:44:0) after 1m0s
[15:25:39.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:44:0)
[15:25:39.230] Timer tick, asking Buildbucket for the build status
[15:25:39.374] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:39.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:45:0) after 1m0s
[15:26:39.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:45:0)
[15:26:39.410] Timer tick, asking Buildbucket for the build status
[15:26:40.004] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:40.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:46:0) after 1m0s
[15:27:40.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:46:0)
[15:27:40.131] Timer tick, asking Buildbucket for the build status
[15:27:40.631] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:40.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:47:0) after 1m0s
[15:28:40.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:47:0)
[15:28:40.852] Timer tick, asking Buildbucket for the build status
[15:28:41.203] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:41.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:48:0) after 1m0s
[15:29:41.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:48:0)
[15:29:41.348] Timer tick, asking Buildbucket for the build status
[15:29:47.025] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:47.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:49:0) after 1m0s
[15:30:47.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:49:0)
[15:30:47.431] Timer tick, asking Buildbucket for the build status
[15:30:47.544] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:47.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:50:0) after 1m0s
[15:31:47.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:50:0)
[15:31:47.948] Timer tick, asking Buildbucket for the build status
[15:31:48.024] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:48.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:51:0) after 1m0s
[15:32:48.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:51:0)
[15:32:48.280] Timer tick, asking Buildbucket for the build status
[15:32:48.357] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:48.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:52:0) after 1m0s
[15:33:48.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:52:0)
[15:33:48.685] Timer tick, asking Buildbucket for the build status
[15:33:48.786] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:48.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:53:0) after 1m0s
[15:34:48.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:53:0)
[15:34:48.849] Timer tick, asking Buildbucket for the build status
[15:34:49.121] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:49.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:54:0) after 1m0s
[15:35:49.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:54:0)
[15:35:49.308] Timer tick, asking Buildbucket for the build status
[15:35:49.416] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:49.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:55:0) after 1m0s
[15:36:49.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:55:0)
[15:36:49.571] Timer tick, asking Buildbucket for the build status
[15:36:49.646] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:49.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:56:0) after 1m0s
[15:37:49.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:56:0)
[15:37:49.744] Timer tick, asking Buildbucket for the build status
[15:37:49.852] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:49.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:57:0) after 1m0s
[15:38:49.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:57:0)
[15:38:49.925] Timer tick, asking Buildbucket for the build status
[15:38:50.073] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:50.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:58:0) after 1m0s
[15:39:50.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:58:0)
[15:39:50.104] Timer tick, asking Buildbucket for the build status
[15:39:50.196] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:50.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:59:0) after 1m0s
[15:40:50.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:59:0)
[15:40:50.231] Timer tick, asking Buildbucket for the build status
[15:40:50.785] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:50.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:60:0) after 1m0s
[15:41:50.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:60:0)
[15:41:50.827] Timer tick, asking Buildbucket for the build status
[15:41:50.935] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:50.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:61:0) after 1m0s
[15:42:50.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:61:0)
[15:42:50.972] Timer tick, asking Buildbucket for the build status
[15:42:51.218] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:51.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:62:0) after 1m0s
[15:43:51.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:62:0)
[15:43:51.252] Timer tick, asking Buildbucket for the build status
[15:43:51.371] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:51.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:63:0) after 1m0s
[15:44:51.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:63:0)
[15:44:51.586] Timer tick, asking Buildbucket for the build status
[15:44:51.715] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:51.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:64:0) after 1m0s
[15:45:51.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:64:0)
[15:45:51.739] Timer tick, asking Buildbucket for the build status
[15:45:51.861] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:51.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:65:0) after 1m0s
[15:46:51.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:65:0)
[15:46:51.925] Timer tick, asking Buildbucket for the build status
[15:46:52.313] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:52.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:66:0) after 1m0s
[15:47:52.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:66:0)
[15:47:52.360] Timer tick, asking Buildbucket for the build status
[15:47:52.426] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:52.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:67:0) after 1m0s
[15:48:52.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:67:0)
[15:48:52.437] Timer tick, asking Buildbucket for the build status
[15:48:52.598] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:52.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:68:0) after 1m0s
[15:49:52.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:68:0)
[15:49:52.671] Timer tick, asking Buildbucket for the build status
[15:49:52.735] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:52.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:69:0) after 1m0s
[15:50:52.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:69:0)
[15:50:52.744] Timer tick, asking Buildbucket for the build status
[15:50:52.831] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:52.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:70:0) after 1m0s
[15:51:52.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:70:0)
[15:51:52.876] Timer tick, asking Buildbucket for the build status
[15:51:52.963] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:52.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:71:0) after 1m0s
[15:52:52.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:71:0)
[15:52:52.990] Timer tick, asking Buildbucket for the build status
[15:52:53.242] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:53.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:72:0) after 1m0s
[15:53:53.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:72:0)
[15:53:53.336] Timer tick, asking Buildbucket for the build status
[15:53:53.475] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:53.475] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:73:0) after 1m0s
[15:54:53.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:73:0)
[15:54:53.515] Timer tick, asking Buildbucket for the build status
[15:54:53.668] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:53.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:74:0) after 1m0s
[15:55:53.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:74:0)
[15:55:53.727] Timer tick, asking Buildbucket for the build status
[15:55:53.818] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:53.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:75:0) after 1m0s
[15:56:53.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:75:0)
[15:56:53.834] Timer tick, asking Buildbucket for the build status
[15:56:53.957] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:53.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:76:0) after 1m0s
[15:57:53.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:76:0)
[15:57:53.975] Timer tick, asking Buildbucket for the build status
[15:57:54.630] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:54.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:77:0) after 1m0s
[15:58:54.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:77:0)
[15:58:54.641] Timer tick, asking Buildbucket for the build status
[15:58:54.782] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:54.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:78:0) after 1m0s
[15:59:54.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:78:0)
[15:59:54.836] Timer tick, asking Buildbucket for the build status
[15:59:54.915] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:54.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:79:0) after 1m0s
[16:00:54.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:79:0)
[16:00:54.940] Timer tick, asking Buildbucket for the build status
[16:00:55.309] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:55.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:80:0) after 1m0s
[16:01:55.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:80:0)
[16:01:55.319] Timer tick, asking Buildbucket for the build status
[16:01:55.415] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:55.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:81:0) after 1m0s
[16:02:55.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:81:0)
[16:02:55.453] Timer tick, asking Buildbucket for the build status
[16:02:55.736] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:55.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:82:0) after 1m0s
[16:03:55.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:82:0)
[16:03:55.732] Timer tick, asking Buildbucket for the build status
[16:03:55.952] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:55.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:83:0) after 1m0s
[16:04:55.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:83:0)
[16:04:55.929] Timer tick, asking Buildbucket for the build status
[16:04:56.006] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:56.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:84:0) after 1m0s
[16:05:56.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:84:0)
[16:05:56.076] Timer tick, asking Buildbucket for the build status
[16:05:56.379] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:56.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:85:0) after 1m0s
[16:06:56.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:85:0)
[16:06:56.406] Timer tick, asking Buildbucket for the build status
[16:06:56.468] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:56.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:86:0) after 1m0s
[16:07:56.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:86:0)
[16:07:56.509] Timer tick, asking Buildbucket for the build status
[16:07:56.757] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:56.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:87:0) after 1m0s
[16:08:56.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:87:0)
[16:08:56.816] Timer tick, asking Buildbucket for the build status
[16:08:58.022] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:58.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:88:0) after 1m0s
[16:09:58.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:88:0)
[16:09:58.041] Timer tick, asking Buildbucket for the build status
[16:09:58.118] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:58.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:89:0) after 1m0s
[16:10:58.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:89:0)
[16:10:58.142] Timer tick, asking Buildbucket for the build status
[16:10:58.226] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:58.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:90:0) after 1m0s
[16:11:58.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:90:0)
[16:11:58.277] Timer tick, asking Buildbucket for the build status
[16:11:58.349] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:58.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:91:0) after 1m0s
[16:12:58.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:91:0)
[16:12:58.340] Timer tick, asking Buildbucket for the build status
[16:12:58.420] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:58.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:92:0) after 1m0s
[16:13:58.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:92:0)
[16:13:58.455] Timer tick, asking Buildbucket for the build status
[16:13:58.597] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:58.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:93:0) after 1m0s
[16:14:58.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:93:0)
[16:14:58.618] Timer tick, asking Buildbucket for the build status
[16:14:58.698] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:58.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:94:0) after 1m0s
[16:15:58.725] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:94:0)
[16:15:58.725] Timer tick, asking Buildbucket for the build status
[16:15:58.852] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:58.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:95:0) after 1m0s
[16:16:58.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:95:0)
[16:16:58.917] Timer tick, asking Buildbucket for the build status
[16:16:58.993] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:58.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:96:0) after 1m0s
[16:17:59.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:96:0)
[16:17:59.105] Timer tick, asking Buildbucket for the build status
[16:17:59.195] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:59.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:97:0) after 1m0s
[16:18:59.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:97:0)
[16:18:59.242] Timer tick, asking Buildbucket for the build status
[16:18:59.367] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:59.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:98:0) after 1m0s
[16:19:59.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:98:0)
[16:19:59.583] Timer tick, asking Buildbucket for the build status
[16:19:59.864] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:59.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:99:0) after 1m0s
[16:20:59.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:99:0)
[16:20:59.909] Timer tick, asking Buildbucket for the build status
[16:20:59.970] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:59.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:100:0) after 1m0s
[16:21:59.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:100:0)
[16:21:59.985] Timer tick, asking Buildbucket for the build status
[16:22:00.216] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:00.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:101:0) after 1m0s
[16:23:01.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:101:0)
[16:23:01.121] Timer tick, asking Buildbucket for the build status
[16:23:01.331] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:01.331] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:102:0) after 1m0s
[16:24:01.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:102:0)
[16:24:01.409] Timer tick, asking Buildbucket for the build status
[16:24:01.534] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:01.534] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:103:0) after 1m0s
[16:25:02.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:103:0)
[16:25:02.216] Timer tick, asking Buildbucket for the build status
[16:25:02.959] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:02.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:104:0) after 1m0s
[16:26:03.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:104:0)
[16:26:03.136] Timer tick, asking Buildbucket for the build status
[16:26:03.704] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:03.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:105:0) after 1m0s
[16:27:03.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:105:0)
[16:27:03.770] Timer tick, asking Buildbucket for the build status
[16:27:03.943] Build 8858754261387577920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:03.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024184323326305584:106:0) after 1m0s
[16:27:22.014] Received PubSub notification, asking Buildbucket for the build status
[16:27:22.083] Build 8858754261387577920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:27:22.083] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610036840142270",
"created_by": "project:chromium",
"created_ts": "1610030607768400",
"id": "8858754261387577920",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"807acce36a4baa1004d23ae896b07e2148ea1533\"}}",
"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\": \"807acce36a4baa1004d23ae896b07e2148ea1533\", \"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-central1-b-8-115-pp3h\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22101, \"got_angle_revision\": \"ca94d1da85979c910be4c185f97f1f1406534634\", \"got_dawn_revision\": \"fac169113df7dad1b55092ab099eabb25e723719\", \"got_nacl_revision\": \"299d4780ec86121ff2a5368ed9435ade0e356e5e\", \"got_revision\": \"807acce36a4baa1004d23ae896b07e2148ea1533\", \"got_revision_cp\": \"refs/heads/master@{#841049}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"7b2f938954180e8945f776d3e202f6a2bda1aaf9\", \"got_v8_revision\": \"8bf25fa0cda754dd0f8e0f8b7c9f8854eabfe72d\", \"got_v8_revision_cp\": \"refs/heads/8.9.213@{#1}\", \"got_webrtc_revision\": \"fc6b87192db6d5e4fd6997814f00b6792cf16180\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32904}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"807acce36a4baa1004d23ae896b07e2148ea1533\", \"swarm_hashes_refs/heads/master(at){#841049}_without_patch\": {\"absl_hardening_tests\": \"ff76addf86daf75b9489b7277427f97a26168e60\", \"accessibility_unittests\": \"060eed28084a743a42344629ae7d53398bc7f608\", \"angle_unittests\": \"e7c4841eefa0e9018cd8a876e08b67e769f087ca\", \"app_list_unittests\": \"d3731460712d18b2bc526c0df1e902f353e4cfff\", \"app_shell_unittests\": \"7636c45ece73cf173bdd07ae6f5ee666542aadf1\", \"ash_unittests\": \"3d8422c0bb4be1373401313b82d14db04f9ba0b2\", \"aura_unittests\": \"178c107512204d812308820359afea63a322b4a0\", \"base_unittests\": \"0be03984582d97bc5c00b22be6b81bbc5b29f0ee\", \"base_util_unittests\": \"a97a345357bd9e54e73b048b8752b6d9dbd1dd70\", \"blink_common_unittests\": \"84425eb31cc7ff32630ff476c2facef2fd8430c8\", \"blink_fuzzer_unittests\": \"bcbc964e63885dfee329eb0ffaf150988ff14ffe\", \"blink_heap_unittests\": \"3642128f09e00149893e9384b5428846500f6583\", \"blink_platform_unittests\": \"401f72f0822467597be70c3f6bcf99a068c90e19\", \"blink_unittests\": \"fbd962a4da12fe77bd1c806879926ba6ed6419a1\", \"boringssl_crypto_tests\": \"9b9fcf2492f80b25c057b156de819c23bbc3748b\", \"boringssl_ssl_tests\": \"d79a8b26ae0c68860a6b2adbffb14f50da027809\", \"browser_tests\": \"b80d52825f6b9d673b6764c02c001e7b14bf034f\", \"capture_unittests\": \"2c6126cafbec52ff9084b7ea6ac8e1c9669662d6\", \"cast_unittests\": \"aa3d640b72ac66baa9e737f26a5485388e5cdd3e\", \"cc_unittests\": \"9316bf855dbd42f0eecc568294cdfe5bdd50b420\", \"chrome_app_unittests\": \"698d4c56283ce67fb0271fa708643a361c770ad0\", \"chromedriver_unittests\": \"974dab383e27c3e86d6c4ae3163304a621449713\", \"chromeos_components_unittests\": \"7ac59eaec52f74d3d56f52bb3c59da950449b0d7\", \"chromeos_unittests\": \"fcac8df0fa0a0edad30cc4350751563b1ece721d\", \"components_browsertests\": \"1bead80968f702966b62956bbdb81b2a88ab8c2b\", \"components_unittests\": \"8ecc09d6efd7ec2b3d427fa9aa0eebd4a463db2e\", \"compositor_unittests\": \"0dfceb8b2f8479b573c874d26635f603ed39fe4c\", \"content_browsertests\": \"9c6708dd52b41b9e20cc9a1b28391b7a187c4e1e\", \"content_unittests\": \"ddda165c4cd5d79eea38a20994a220beffceb783\", \"crashpad_tests\": \"888d39d829084ed63413a053ff59de40dc600b5b\", \"crypto_unittests\": \"0be292284fa584aa50f003bbea212dbf95ae746f\", \"dbus_unittests\": \"e13b0d133d9c9220002d8f2a1b6829f5c897aac2\", \"device_unittests\": \"fcdd86ff920811517249d80f2eaedd2536cedcdf\", \"display_unittests\": \"e0197e047d43ca002fe3143476bd63dd47521182\", \"events_unittests\": \"84a4da9530b57eba4ea68d21d50110938c6dfacd\", \"exo_unittests\": \"f4153694816977c2bde8af160b554f84b04e293d\", \"extensions_browsertests\": \"4dccf9591bc832ae8f83cd6377b6b124fd8c2dc1\", \"extensions_unittests\": \"2190e2a9c27ba5a4ac879def3a7f8ebb05b528e2\", \"filesystem_service_unittests\": \"087c06c386b34a2468810166b832c4170d66ce6a\", \"gcm_unit_tests\": \"e8971df166ee77c02abeca683643ff189d1f008a\", \"gfx_unittests\": \"69d07c4943393043f0f5751cb28124cf0c62d215\", \"gin_unittests\": \"94bd275139ead88796307eb14d8d391479448c01\", \"gl_unittests_ozone\": \"e87fd3ffa218664bb0a3e69d6076ec5bbc854142\", \"google_apis_unittests\": \"9175890cb697c948eef0e34586f4f667e406c19f\", \"gpu_unittests\": \"b6e5962cb0e9f2463f845ea477e33257b1909170\", \"gwp_asan_unittests\": \"72318bd4873f79e4b7ec364e178c93f7b1e3751e\", \"interactive_ui_tests\": \"1e22f25b7c01c84b0adc7713dd296ea502b24b42\", \"ipc_tests\": \"3bfa060245c14cb669f77cd34d159bff989b999f\", \"jingle_unittests\": \"710e304b0cabb2b6e09ed423b5d2c80dc707da29\", \"keyboard_unittests\": \"ca945a448eec88ca0a78ece5e3058c5437826dfb\", \"latency_unittests\": \"0e8278b68f0ffa2ccadd3dc97410cae019c1f9c9\", \"libjingle_xmpp_unittests\": \"06f66a41521a1398a252ba5e13350eb492c7d1f2\", \"liburlpattern_unittests\": \"47677c7d329cdf7f8fcc83e8f18b92afa1ab0f89\", \"media_blink_unittests\": \"90076736e59359c5f00a3ae8fd5893e2b6c9f9b8\", \"media_unittests\": \"c843b8d03cc0b146cb1396625c131ab171b5bdb4\", \"message_center_unittests\": \"6eb833ec5bbb1df9b8316327bb8d81efdd8c09dc\", \"midi_unittests\": \"f45395ac7a464665b8848ae247211530bcccbdfb\", \"mojo_core_unittests\": \"12b481dfe00428afa603ec5337a0f823ce002ac7\", \"mojo_unittests\": \"57779e2065fff830a04dd16708e86110d03afdaf\", \"nacl_helper_nonsfi_unittests\": \"bb26fdbc10b63a87bc924370666902834f7f140e\", \"nacl_loader_unittests\": \"1bb5b05ea45398dd33283deecdde6fb275a58993\", \"native_theme_unittests\": \"08f05c46bf5f345c80bed0c5efc394737021d0c9\", \"net_unittests\": \"bf477ef4e1d13048956ea8598b49548496d572ab\", \"ozone_gl_unittests\": \"241efc2f2455efeeea8484191516c060ee5c6c31\", \"ozone_unittests\": \"990d6d4fc86c5b91bce117b0311976668758c5d6\", \"ozone_x11_unittests\": \"c47dd1320d2a4f4a23fa4900f8204bc90825fb55\", \"pdf_unittests\": \"cc719bef891866af6063b1bf2cf7e0c4b9701b90\", \"perfetto_unittests\": \"b6175db7923fb669dd3febf3be99aaa87afc15b5\", \"ppapi_unittests\": \"4f043c510ec4005972b23ac58e0355f27d14be3d\", \"printing_unittests\": \"0cf9aa0e7b7849ce29d561d610a36d8b25179b55\", \"remoting_unittests\": \"dd7a756d06405e2a4ab76076eab7a4bd524367d9\", \"sandbox_linux_unittests\": \"2dd65c94f2fada426bbd01ba2d8050a321e291e7\", \"service_manager_unittests\": \"df4621543286335d7014aee10e2f7d5c5f9ad16e\", \"services_unittests\": \"14ece70ee134352e0a72e12353ee775f0e33c831\", \"shell_dialogs_unittests\": \"5265f3ad0a2723191421b05b037e610a119e2b30\", \"shell_encryption_unittests\": \"dc7f9d102f16e12eac5207ffb4f5290b5d82578e\", \"skia_unittests\": \"dc8d9e688d768577c66fec33fcc5ca7a327f60cb\", \"snapshot_unittests\": \"2b03389673b88f1af65a09840089f33648f8fb57\", \"sql_unittests\": \"a6847ce28619e31eb3fc66ba58c5c7b33d3c2763\", \"storage_unittests\": \"c1ba3bd6f36007eb2b2b3d798f988dcad0c5ded4\", \"sync_integration_tests\": \"26cbb1f35b6a36fc5117147b46c17d3e922a7810\", \"traffic_annotation_auditor_unittests\": \"7415f174c7ae1bf2fec5a9e88c554fd5f133e51a\", \"ui_base_unittests\": \"edeae7140d219b406358975430b3d33c3f2ff286\", \"ui_chromeos_unittests\": \"3f1f7257411d14f5f072460215df03ce8f0f5b07\", \"ui_touch_selection_unittests\": \"39b19d638b1237f59515066194fc92e99ab9b2a9\", \"unit_tests\": \"ee5c8981341cc3f85c8a6038a255cfc9609e54f7\", \"url_unittests\": \"93e11b51ad2a5ce260402779696a8bdd000d383d\", \"usage_time_limit_unittests\": \"5a8c399baa7a0e57d6b6f918ccebce7606c6359f\", \"views_unittests\": \"bed783429834fef14bb657c26baecb2a74e03b24\", \"viz_unittests\": \"9901bf7b37c2547cdb747e3d238682b9502b690f\", \"wm_unittests\": \"95fe0ee4bb3fc652795701f464278ada99664283\", \"wtf_unittests\": \"87ee0afd906eb3510b4caa55a35e37cf84294cfc\", \"zlib_unittests\": \"b62df2826b40b77d324a70c5d50109cbd6e7daf7\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_51829829c31fbaf3768e3309e640f1ed37e0867e138bde8c875431bcab07adc2_v2\", \"builder_7f66e4b9df9a4fde5765030780da31d05e9d75a20736158540de9973fc71d08c_v2\", \"builder_db66d224f5e060c065cb4a49cc418612a90bf947378d00f79622922b6c0b5060_v2\", \"builder_dbe717e93dfefb94e765b2da7ffc34b16e5134b01772a8d37ee52c1fe1505654_v2\", \"builder_fe96da9c6a19fa2fc3ad0c2b7020b7cb68e4a92161f4cd6cb7dc1d1e2d5af5dc_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-central1-b-8-115-pp3h\"], \"image\": [\"chrome-xenial-20122700-a13233ce10d\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610030609503632",
"status": "COMPLETED",
"status_changed_ts": "1610036840779648",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22101",
"builder:linux-chromeos-dbg",
"buildset:commit/git/807acce36a4baa1004d23ae896b07e2148ea1533",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/807acce36a4baa1004d23ae896b07e2148ea1533",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024184323326305584",
"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/8858754261387577920/+/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:50f61ef9f3b75c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1610036840807098",
"url": "https://ci.chromium.org/b/8858754261387577920",
"utcnow_ts": "1610036842074041"
}
}
[16:27:22.083] Invocation finished in 1h43m55.547523087s with status SUCCEEDED