[00:15:30.301] New invocation is queued and will start shortly
[00:15:31.668] Starting the invocation (attempt 1)
[00:15:31.707] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:15:31.707] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:15:31.708] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9111483807936361376",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"aa324ebf0704d71f90c7bc9055120691481bc5b8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9111483807936361376",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa324ebf0704d71f90c7bc9055120691481bc5b8",
"gitiles_ref:refs/heads/master"
]
}
[00:15:35.033] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1526775331815530",
"experimental": true,
"id": "8946053745625073296",
"lease_expiration_ts": "1526811334757540",
"lease_key": "1552783512",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"aa324ebf0704d71f90c7bc9055120691481bc5b8\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1526775334950280",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/45",
"builder:linux-chromeos-dbg",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa324ebf0704d71f90c7bc9055120691481bc5b8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9111483807936361376",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_dimension:builder:linux-chromeos-dbg",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/linux-chromeos-dbg/45",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8946053745625073296",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:06be006c935279af3663102925cce4dcc526e425",
"swarming_tag:builder:linux-chromeos-dbg",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa324ebf0704d71f90c7bc9055120691481bc5b8",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8946053745625073296/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:60",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9111483807936361376",
"swarming_tag:scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3d93b848768d7c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1526775334950300",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/linux-chromeos-dbg/45",
"utcnow_ts": "1526775335019040"
}
}
[00:15:35.033] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/linux-chromeos-dbg/45
[00:15:35.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:2:0) after 1m0s
[00:15:46.724] Received PubSub notification, asking Buildbucket for the build status
[00:15:46.798] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:35.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:2:0)
[00:16:35.101] Timer tick, asking Buildbucket for the build status
[00:16:35.278] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:35.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:4:0) after 1m0s
[00:17:35.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:4:0)
[00:17:35.395] Timer tick, asking Buildbucket for the build status
[00:17:35.713] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:35.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:5:0) after 1m0s
[00:18:35.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:5:0)
[00:18:35.730] Timer tick, asking Buildbucket for the build status
[00:18:35.786] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:35.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:6:0) after 1m0s
[00:19:35.805] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:6:0)
[00:19:35.805] Timer tick, asking Buildbucket for the build status
[00:19:35.965] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:35.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:7:0) after 1m0s
[00:20:35.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:7:0)
[00:20:35.981] Timer tick, asking Buildbucket for the build status
[00:20:36.044] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:36.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:8:0) after 1m0s
[00:21:36.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:8:0)
[00:21:36.069] Timer tick, asking Buildbucket for the build status
[00:21:36.170] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:36.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:9:0) after 1m0s
[00:22:36.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:9:0)
[00:22:36.187] Timer tick, asking Buildbucket for the build status
[00:22:36.361] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:36.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:10:0) after 1m0s
[00:23:36.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:10:0)
[00:23:36.379] Timer tick, asking Buildbucket for the build status
[00:23:36.492] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:36.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:11:0) after 1m0s
[00:24:36.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:11:0)
[00:24:36.511] Timer tick, asking Buildbucket for the build status
[00:24:36.826] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:36.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:12:0) after 1m0s
[00:25:36.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:12:0)
[00:25:36.846] Timer tick, asking Buildbucket for the build status
[00:25:36.901] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:36.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:13:0) after 1m0s
[00:26:36.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:13:0)
[00:26:36.919] Timer tick, asking Buildbucket for the build status
[00:26:36.983] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:36.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:14:0) after 1m0s
[00:27:37.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:14:0)
[00:27:37.002] Timer tick, asking Buildbucket for the build status
[00:27:37.060] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:37.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:15:0) after 1m0s
[00:28:37.078] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:15:0)
[00:28:37.078] Timer tick, asking Buildbucket for the build status
[00:28:37.328] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:37.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:16:0) after 1m0s
[00:29:37.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:16:0)
[00:29:37.345] Timer tick, asking Buildbucket for the build status
[00:29:37.401] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:37.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:17:0) after 1m0s
[00:30:37.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:17:0)
[00:30:37.418] Timer tick, asking Buildbucket for the build status
[00:30:37.719] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:37.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:18:0) after 1m0s
[00:31:37.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:18:0)
[00:31:37.743] Timer tick, asking Buildbucket for the build status
[00:31:37.895] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:37.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:19:0) after 1m0s
[00:32:37.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:19:0)
[00:32:37.912] Timer tick, asking Buildbucket for the build status
[00:32:37.997] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:37.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:20:0) after 1m0s
[00:33:38.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:20:0)
[00:33:38.025] Timer tick, asking Buildbucket for the build status
[00:33:38.199] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:38.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:21:0) after 1m0s
[00:34:38.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:21:0)
[00:34:38.488] Timer tick, asking Buildbucket for the build status
[00:34:38.715] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:38.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:22:0) after 1m0s
[00:35:38.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:22:0)
[00:35:38.732] Timer tick, asking Buildbucket for the build status
[00:35:38.896] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:38.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:23:0) after 1m0s
[00:36:38.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:23:0)
[00:36:38.919] Timer tick, asking Buildbucket for the build status
[00:36:39.014] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:39.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:24:0) after 1m0s
[00:37:39.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:24:0)
[00:37:39.045] Timer tick, asking Buildbucket for the build status
[00:37:39.107] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:39.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:25:0) after 1m0s
[00:38:39.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:25:0)
[00:38:39.238] Timer tick, asking Buildbucket for the build status
[00:38:39.472] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:39.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:26:0) after 1m0s
[00:39:39.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:26:0)
[00:39:39.569] Timer tick, asking Buildbucket for the build status
[00:39:39.729] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:39.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:27:0) after 1m0s
[00:40:39.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:27:0)
[00:40:39.814] Timer tick, asking Buildbucket for the build status
[00:40:39.884] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:39.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:28:0) after 1m0s
[00:41:40.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:28:0)
[00:41:40.017] Timer tick, asking Buildbucket for the build status
[00:41:40.137] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:40.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:29:0) after 1m0s
[00:42:40.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:29:0)
[00:42:40.269] Timer tick, asking Buildbucket for the build status
[00:42:40.357] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:40.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:30:0) after 1m0s
[00:43:40.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:30:0)
[00:43:40.460] Timer tick, asking Buildbucket for the build status
[00:43:40.521] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:40.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:31:0) after 1m0s
[00:44:40.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:31:0)
[00:44:40.674] Timer tick, asking Buildbucket for the build status
[00:44:40.902] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:40.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:32:0) after 1m0s
[00:45:40.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:32:0)
[00:45:40.923] Timer tick, asking Buildbucket for the build status
[00:45:41.030] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:41.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:33:0) after 1m0s
[00:46:41.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:33:0)
[00:46:41.088] Timer tick, asking Buildbucket for the build status
[00:46:41.233] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:41.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:34:0) after 1m0s
[00:47:41.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:34:0)
[00:47:41.295] Timer tick, asking Buildbucket for the build status
[00:47:41.377] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:41.377] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:35:0) after 1m0s
[00:48:41.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:35:0)
[00:48:41.518] Timer tick, asking Buildbucket for the build status
[00:48:41.676] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:41.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:36:0) after 1m0s
[00:49:41.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:36:0)
[00:49:41.699] Timer tick, asking Buildbucket for the build status
[00:49:41.789] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:41.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:37:0) after 1m0s
[00:50:41.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:37:0)
[00:50:41.834] Timer tick, asking Buildbucket for the build status
[00:50:41.894] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:41.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:38:0) after 1m0s
[00:51:42.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:38:0)
[00:51:42.033] Timer tick, asking Buildbucket for the build status
[00:51:42.209] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:42.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:39:0) after 1m0s
[00:52:42.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:39:0)
[00:52:42.274] Timer tick, asking Buildbucket for the build status
[00:52:42.442] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:42.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:40:0) after 1m0s
[00:53:42.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:40:0)
[00:53:42.529] Timer tick, asking Buildbucket for the build status
[00:53:42.710] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:42.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:41:0) after 1m0s
[00:54:42.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:41:0)
[00:54:42.845] Timer tick, asking Buildbucket for the build status
[00:54:42.907] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:42.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:42:0) after 1m0s
[00:55:43.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:42:0)
[00:55:43.042] Timer tick, asking Buildbucket for the build status
[00:55:43.184] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:43.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:43:0) after 1m0s
[00:56:43.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:43:0)
[00:56:43.253] Timer tick, asking Buildbucket for the build status
[00:56:43.421] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:43.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:44:0) after 1m0s
[00:57:43.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:44:0)
[00:57:43.593] Timer tick, asking Buildbucket for the build status
[00:57:43.790] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:43.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:45:0) after 1m0s
[00:58:43.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:45:0)
[00:58:43.849] Timer tick, asking Buildbucket for the build status
[00:58:43.974] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:43.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:46:0) after 1m0s
[00:59:44.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:46:0)
[00:59:44.076] Timer tick, asking Buildbucket for the build status
[00:59:44.204] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:44.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:47:0) after 1m0s
[01:00:44.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:47:0)
[01:00:44.335] Timer tick, asking Buildbucket for the build status
[01:00:44.428] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:44.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:48:0) after 1m0s
[01:01:44.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:48:0)
[01:01:44.480] Timer tick, asking Buildbucket for the build status
[01:01:44.560] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:44.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:49:0) after 1m0s
[01:02:44.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:49:0)
[01:02:44.646] Timer tick, asking Buildbucket for the build status
[01:02:44.734] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:44.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:50:0) after 1m0s
[01:03:44.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:50:0)
[01:03:44.794] Timer tick, asking Buildbucket for the build status
[01:03:45.017] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:45.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:51:0) after 1m0s
[01:04:45.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:51:0)
[01:04:45.036] Timer tick, asking Buildbucket for the build status
[01:04:45.096] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:45.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:52:0) after 1m0s
[01:05:45.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:52:0)
[01:05:45.231] Timer tick, asking Buildbucket for the build status
[01:05:45.550] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:45.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:53:0) after 1m0s
[01:06:45.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:53:0)
[01:06:45.579] Timer tick, asking Buildbucket for the build status
[01:06:45.715] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:45.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:54:0) after 1m0s
[01:07:45.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:54:0)
[01:07:45.750] Timer tick, asking Buildbucket for the build status
[01:07:45.811] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:45.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:55:0) after 1m0s
[01:08:45.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:55:0)
[01:08:45.833] Timer tick, asking Buildbucket for the build status
[01:08:45.983] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:45.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:56:0) after 1m0s
[01:09:46.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:56:0)
[01:09:46.009] Timer tick, asking Buildbucket for the build status
[01:09:46.095] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:46.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:57:0) after 1m0s
[01:10:46.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:57:0)
[01:10:46.210] Timer tick, asking Buildbucket for the build status
[01:10:46.312] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:46.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:58:0) after 1m0s
[01:11:46.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:58:0)
[01:11:46.442] Timer tick, asking Buildbucket for the build status
[01:11:46.590] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:46.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:59:0) after 1m0s
[01:12:46.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:59:0)
[01:12:46.711] Timer tick, asking Buildbucket for the build status
[01:12:46.801] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:46.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:60:0) after 1m0s
[01:13:46.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:60:0)
[01:13:46.822] Timer tick, asking Buildbucket for the build status
[01:13:46.878] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:46.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:61:0) after 1m0s
[01:14:46.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:61:0)
[01:14:46.921] Timer tick, asking Buildbucket for the build status
[01:14:46.992] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:46.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:62:0) after 1m0s
[01:15:47.020] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:62:0)
[01:15:47.020] Timer tick, asking Buildbucket for the build status
[01:15:47.087] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:47.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:63:0) after 1m0s
[01:16:47.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:63:0)
[01:16:47.115] Timer tick, asking Buildbucket for the build status
[01:16:47.265] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:47.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:64:0) after 1m0s
[01:17:47.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:64:0)
[01:17:47.305] Timer tick, asking Buildbucket for the build status
[01:17:47.379] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:47.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:65:0) after 1m0s
[01:18:47.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:65:0)
[01:18:47.405] Timer tick, asking Buildbucket for the build status
[01:18:47.473] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:47.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:66:0) after 1m0s
[01:19:47.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:66:0)
[01:19:47.495] Timer tick, asking Buildbucket for the build status
[01:19:47.562] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:47.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:67:0) after 1m0s
[01:20:47.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:67:0)
[01:20:47.580] Timer tick, asking Buildbucket for the build status
[01:20:47.646] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:47.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:68:0) after 1m0s
[01:21:47.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:68:0)
[01:21:47.665] Timer tick, asking Buildbucket for the build status
[01:21:47.731] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:47.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:69:0) after 1m0s
[01:22:47.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:69:0)
[01:22:47.750] Timer tick, asking Buildbucket for the build status
[01:22:47.891] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:47.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:70:0) after 1m0s
[01:23:47.912] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:70:0)
[01:23:47.912] Timer tick, asking Buildbucket for the build status
[01:23:47.979] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:47.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:71:0) after 1m0s
[01:24:47.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:71:0)
[01:24:47.998] Timer tick, asking Buildbucket for the build status
[01:24:48.175] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:48.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:72:0) after 1m0s
[01:25:48.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:72:0)
[01:25:48.245] Timer tick, asking Buildbucket for the build status
[01:25:48.366] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:48.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:73:0) after 1m0s
[01:26:48.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:73:0)
[01:26:48.386] Timer tick, asking Buildbucket for the build status
[01:26:48.524] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:48.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:74:0) after 1m0s
[01:27:48.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:74:0)
[01:27:48.558] Timer tick, asking Buildbucket for the build status
[01:27:48.626] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:48.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:75:0) after 1m0s
[01:28:48.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:75:0)
[01:28:48.650] Timer tick, asking Buildbucket for the build status
[01:28:48.721] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:48.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:76:0) after 1m0s
[01:29:48.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:76:0)
[01:29:48.743] Timer tick, asking Buildbucket for the build status
[01:29:48.813] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:48.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:77:0) after 1m0s
[01:30:48.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:77:0)
[01:30:48.849] Timer tick, asking Buildbucket for the build status
[01:30:48.983] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:48.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:78:0) after 1m0s
[01:31:49.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:78:0)
[01:31:49.003] Timer tick, asking Buildbucket for the build status
[01:31:49.148] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:49.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:79:0) after 1m0s
[01:32:49.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:79:0)
[01:32:49.178] Timer tick, asking Buildbucket for the build status
[01:32:49.277] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:49.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:80:0) after 1m0s
[01:33:49.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:80:0)
[01:33:49.369] Timer tick, asking Buildbucket for the build status
[01:33:49.482] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:49.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:81:0) after 1m0s
[01:34:49.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:81:0)
[01:34:49.503] Timer tick, asking Buildbucket for the build status
[01:34:49.619] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:49.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:82:0) after 1m0s
[01:35:49.647] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:82:0)
[01:35:49.647] Timer tick, asking Buildbucket for the build status
[01:35:49.829] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:49.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:83:0) after 1m0s
[01:36:49.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:83:0)
[01:36:49.848] Timer tick, asking Buildbucket for the build status
[01:36:49.901] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:49.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:84:0) after 1m0s
[01:37:49.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:84:0)
[01:37:49.922] Timer tick, asking Buildbucket for the build status
[01:37:50.046] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:50.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:85:0) after 1m0s
[01:38:50.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:85:0)
[01:38:50.080] Timer tick, asking Buildbucket for the build status
[01:38:50.191] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:50.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:86:0) after 1m0s
[01:39:50.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:86:0)
[01:39:50.209] Timer tick, asking Buildbucket for the build status
[01:39:50.286] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:50.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:87:0) after 1m0s
[01:40:50.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:87:0)
[01:40:50.353] Timer tick, asking Buildbucket for the build status
[01:40:50.529] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:50.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:88:0) after 1m0s
[01:41:50.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:88:0)
[01:41:50.615] Timer tick, asking Buildbucket for the build status
[01:41:50.706] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:50.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:89:0) after 1m0s
[01:42:50.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:89:0)
[01:42:50.797] Timer tick, asking Buildbucket for the build status
[01:42:50.931] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:50.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:90:0) after 1m0s
[01:43:50.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:90:0)
[01:43:50.996] Timer tick, asking Buildbucket for the build status
[01:43:51.118] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:51.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:91:0) after 1m0s
[01:44:51.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:91:0)
[01:44:51.173] Timer tick, asking Buildbucket for the build status
[01:44:51.232] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:51.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:92:0) after 1m0s
[01:45:51.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:92:0)
[01:45:51.375] Timer tick, asking Buildbucket for the build status
[01:45:51.547] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:51.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:93:0) after 1m0s
[01:46:51.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:93:0)
[01:46:51.569] Timer tick, asking Buildbucket for the build status
[01:46:51.629] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:51.629] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:94:0) after 1m0s
[01:47:51.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:94:0)
[01:47:51.745] Timer tick, asking Buildbucket for the build status
[01:47:54.063] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:54.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:95:0) after 1m0s
[01:48:54.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:95:0)
[01:48:54.087] Timer tick, asking Buildbucket for the build status
[01:48:54.165] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:54.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:96:0) after 1m0s
[01:49:54.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:96:0)
[01:49:54.185] Timer tick, asking Buildbucket for the build status
[01:49:54.298] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:54.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:97:0) after 1m0s
[01:50:54.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:97:0)
[01:50:54.353] Timer tick, asking Buildbucket for the build status
[01:50:54.426] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:54.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:98:0) after 1m0s
[01:51:54.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:98:0)
[01:51:54.445] Timer tick, asking Buildbucket for the build status
[01:51:54.509] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:54.509] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:99:0) after 1m0s
[01:52:54.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:99:0)
[01:52:54.540] Timer tick, asking Buildbucket for the build status
[01:52:54.607] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:54.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:100:0) after 1m0s
[01:53:54.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:100:0)
[01:53:54.627] Timer tick, asking Buildbucket for the build status
[01:53:54.683] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:54.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:101:0) after 1m0s
[01:54:54.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:101:0)
[01:54:54.703] Timer tick, asking Buildbucket for the build status
[01:54:54.774] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:54.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:102:0) after 1m0s
[01:55:54.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:102:0)
[01:55:54.792] Timer tick, asking Buildbucket for the build status
[01:55:54.862] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:54.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:103:0) after 1m0s
[01:56:54.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:103:0)
[01:56:54.967] Timer tick, asking Buildbucket for the build status
[01:56:55.045] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:55.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:104:0) after 1m0s
[01:57:55.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:104:0)
[01:57:55.065] Timer tick, asking Buildbucket for the build status
[01:57:55.223] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:55.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:105:0) after 1m0s
[01:58:55.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:105:0)
[01:58:55.244] Timer tick, asking Buildbucket for the build status
[01:58:55.421] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:55.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:106:0) after 1m0s
[01:59:55.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:106:0)
[01:59:55.444] Timer tick, asking Buildbucket for the build status
[01:59:55.506] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:55.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:107:0) after 1m0s
[02:00:55.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:107:0)
[02:00:55.526] Timer tick, asking Buildbucket for the build status
[02:00:55.639] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:55.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:108:0) after 1m0s
[02:01:55.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:108:0)
[02:01:55.661] Timer tick, asking Buildbucket for the build status
[02:01:55.921] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:55.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:109:0) after 1m0s
[02:02:55.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:109:0)
[02:02:55.941] Timer tick, asking Buildbucket for the build status
[02:02:56.093] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:56.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:110:0) after 1m0s
[02:03:56.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:110:0)
[02:03:56.113] Timer tick, asking Buildbucket for the build status
[02:03:56.192] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:56.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:111:0) after 1m0s
[02:04:56.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:111:0)
[02:04:56.271] Timer tick, asking Buildbucket for the build status
[02:04:56.738] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:56.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:112:0) after 1m0s
[02:05:56.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:112:0)
[02:05:56.763] Timer tick, asking Buildbucket for the build status
[02:05:56.989] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:56.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:113:0) after 1m0s
[02:06:57.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:113:0)
[02:06:57.016] Timer tick, asking Buildbucket for the build status
[02:06:57.115] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:57.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:114:0) after 1m0s
[02:07:57.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:114:0)
[02:07:57.142] Timer tick, asking Buildbucket for the build status
[02:07:57.322] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:57.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:115:0) after 1m0s
[02:08:57.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:115:0)
[02:08:57.346] Timer tick, asking Buildbucket for the build status
[02:08:57.458] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:57.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:116:0) after 1m0s
[02:09:57.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:116:0)
[02:09:57.480] Timer tick, asking Buildbucket for the build status
[02:09:57.581] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:57.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:117:0) after 1m0s
[02:10:57.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:117:0)
[02:10:57.600] Timer tick, asking Buildbucket for the build status
[02:10:57.738] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:57.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:118:0) after 1m0s
[02:11:57.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:118:0)
[02:11:57.761] Timer tick, asking Buildbucket for the build status
[02:11:57.906] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:57.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:119:0) after 1m0s
[02:12:57.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:119:0)
[02:12:57.925] Timer tick, asking Buildbucket for the build status
[02:12:57.978] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:57.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:120:0) after 1m0s
[02:13:57.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:120:0)
[02:13:57.999] Timer tick, asking Buildbucket for the build status
[02:13:58.094] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:58.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:121:0) after 1m0s
[02:14:58.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:121:0)
[02:14:58.115] Timer tick, asking Buildbucket for the build status
[02:14:58.183] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:58.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:122:0) after 1m0s
[02:15:58.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:122:0)
[02:15:58.212] Timer tick, asking Buildbucket for the build status
[02:15:58.273] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:58.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:123:0) after 1m0s
[02:16:58.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:123:0)
[02:16:58.294] Timer tick, asking Buildbucket for the build status
[02:16:58.353] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:58.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:124:0) after 1m0s
[02:17:58.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:124:0)
[02:17:58.377] Timer tick, asking Buildbucket for the build status
[02:17:58.502] Build 8946053745625073296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:58.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9111483807936361376:125:0) after 1m0s
[02:18:01.781] Received PubSub notification, asking Buildbucket for the build status
[02:18:02.004] Build 8946053745625073296: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:18:02.004] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1526782679320110",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1526775331815530",
"experimental": true,
"id": "8946053745625073296",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"aa324ebf0704d71f90c7bc9055120691481bc5b8\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"task_result\": {\"cipd_pins\": {\"packages\": [{\"path\": \".\", \"version\": \"e4b90cad477c47ea00ff4dbd6183667bb0f1a82c\", \"package_name\": \"infra/tools/luci/kitchen/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"c7fd5d2f9d9f0ea85454eb32690f41ef1d29c749\", \"package_name\": \"infra/git/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"46c0c897ca0f053799ee41fd148bb7a47232df47\", \"package_name\": \"infra/python/cpython/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"6e5ff69bbe48c38117c44fd735cb7adb32417549\", \"package_name\": \"infra/tools/buildbucket/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"4672ed11a416bb60e9ec6738dab9cc41386971f5\", \"package_name\": \"infra/tools/cloudtail/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"139d6a6663b2cdd9420516c9335d0731dd2c5c58\", \"package_name\": \"infra/tools/git/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"df53a719b65668e3b16ecdb600f29f8c901cd67e\", \"package_name\": \"infra/tools/luci-auth/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"72f5c9ec60e557643b06eac503836fb78359ca06\", \"package_name\": \"infra/tools/luci/git-credential-luci/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"defef80b8231a429bb8b4931798307272a536717\", \"package_name\": \"infra/tools/luci/vpython-native/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"8bf6a502584cb13fdb2bb5dcbc7bbb59a6d983a5\", \"package_name\": \"infra/tools/luci/vpython/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"7ac9ea00b7d1d664e9015d2bbd537bc8cb3bfda4\", \"package_name\": \"infra/tools/prpc/linux-amd64\"}, {\"path\": \"kitchen-checkout\", \"version\": \"7a77df12f1ff01f8d83fcda66f98677f0b67f357\", \"package_name\": \"infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\"}], \"client_package\": {\"version\": \"e891a48eebcd04fee5b054173539b558cbcc027c\", \"package_name\": \"infra/tools/cipd/linux-amd64\"}}, \"run_id\": \"3d93b848768d7c11\", \"outputs_ref\": {\"isolatedserver\": \"https://isolateserver.appspot.com\", \"namespace\": \"default-gzip\", \"isolated\": \"6c47cf11e2e3a973d5a975d3f7b754883b5bcffd\"}, \"server_versions\": [\"3551-c9816d0\"], \"duration\": 7324.0531010627747, \"completed_ts\": \"2018-05-20T02:17:59.320110\", \"started_ts\": \"2018-05-20T00:15:45.606290\", \"internal_failure\": false, \"exit_code\": \"0\", \"state\": \"COMPLETED\", \"bot_version\": \"57022332981f5283a1712485c1f04cb7c6b22c564bac3a7d32c50ec8eb0b407e\", \"tags\": [\"build_address:luci.chromium.ci/linux-chromeos-dbg/45\", \"buildbucket_bucket:luci.chromium.ci\", \"buildbucket_build_id:8946053745625073296\", \"buildbucket_hostname:cr-buildbucket.appspot.com\", \"buildbucket_template_canary:0\", \"buildbucket_template_revision:06be006c935279af3663102925cce4dcc526e425\", \"builder:linux-chromeos-dbg\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa324ebf0704d71f90c7bc9055120691481bc5b8\", \"cores:8\", \"cpu:x86-64\", \"gitiles_ref:refs/heads/master\", \"log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8946053745625073296/+/annotations\", \"luci_project:chromium\", \"os:Ubuntu-14.04\", \"pool:luci.chromium.ci\", \"priority:60\", \"recipe_name:chromium\", \"recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\", \"scheduler_invocation_id:9111483807936361376\", \"scheduler_job_id:chromium/linux-chromeos-dbg\", \"service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com\", \"user:None\", \"user_agent:luci-scheduler\", \"vpython:native-python-wrapper\"], \"failure\": false, \"modified_ts\": \"2018-05-20T02:17:59.320110\", \"user\": \"\", \"children_task_ids\": [\"3d93f1f228631c10\", \"3d93f1f685541310\", \"3d93f1fac3878110\", \"3d93f1fe939f4f10\", \"3d93f202e560a310\", \"3d93f208e712e610\", \"3d93f20cd9759d10\", \"3d93f210b3aeee10\", \"3d93f21525b05910\", \"3d93f21bf1b33510\", \"3d93f2220a3ac710\", \"3d93f223aa4bdf10\", \"3d93f224eb4af610\", \"3d93f226ac935f10\", \"3d93f22a2b399f10\", \"3d93f22bc7723c10\", \"3d93f22de4d46410\", \"3d93f2301ca1f410\", \"3d93f2322de56410\", \"3d93f23487914510\", \"3d93f235ea75d110\", \"3d93f23738c8bf10\", \"3d93f23a1f8ed610\", \"3d93f23eda3e0010\", \"3d93f2410ebdff10\", \"3d93f243d9855c10\", \"3d93f2463a05b810\", \"3d93f2479b7a2510\", \"3d93f2490f301e10\", \"3d93f24d136c2610\", \"3d93f250a821a010\", \"3d93f25497026210\", \"3d93f2589da67510\", \"3d93f25bf0f05a10\", \"3d93f2600a42cd10\", \"3d93f26676168010\", \"3d93f26a3e6b6910\", \"3d93f26b82faed10\", \"3d93f26f3cfddb10\", \"3d93f27363d0f410\", \"3d93f276fac14d10\", \"3d93f27a87be7410\", \"3d93f27f3018a810\", \"3d93f282de286110\", \"3d93f28673ffb110\", \"3d93f28a668b5410\", \"3d93f28e76034510\", \"3d93f2925d811a10\", \"3d93f295b7348410\", \"3d93f2993f0de610\", \"3d93f29c379c8410\", \"3d93f2a03ae03e10\", \"3d93f2a3d2ca7b10\", \"3d93f2a7665cfd10\", \"3d93f2ab89e02610\", \"3d93f2aeff1a3810\", \"3d93f2b291446a10\", \"3d93f2b644f89d10\", \"3d93f2ba94532510\", \"3d93f2c07dd50a10\", \"3d93f2c4a7c21110\", \"3d93f2c84591f610\", \"3d93f2cc60510110\", \"3d93f2d2d35ba810\", \"3d93f2d7ce054d10\", \"3d93f2db6d96b110\", \"3d93f2df3d445c10\", \"3d93f2e2d0e94510\", \"3d93f2e7da1cae10\", \"3d93f2ec10de9010\", \"3d93f2f00dcd0310\", \"3d93f2f406040710\", \"3d93f2f7db796e10\", \"3d93f2fb48438810\", \"3d93f30163849310\", \"3d93f306b1a81910\", \"3d93f30b3717da10\", \"3d93f30f4ef77a10\", \"3d93f3141d864210\", \"3d93f318dff42710\", \"3d93f31c723f7510\", \"3d93f320c02f4510\", \"3d93f3246edf6710\", \"3d93f3290f8cee10\", \"3d93f32d3619c610\"], \"created_ts\": \"2018-05-20T00:15:32.838970\", \"name\": \"bb-8946053745625073296-chromium-linux-chromeos-dbg\", \"task_id\": \"3d93b848768d7c10\", \"bot_dimensions\": [{\"value\": [\"linux-chromeos-dbg\"], \"key\": \"builder\"}, {\"value\": [\"builder_6f20ff6d9065c03ecd0e620fd3dc6e7d0c4888eca1ca5067106334f3a3b39f2d_v2\", \"git\", \"goma\", \"goma_v2\", \"vpython\"], \"key\": \"caches\"}, {\"value\": [\"8\"], \"key\": \"cores\"}, {\"value\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"key\": \"cpu\"}, {\"value\": [\"none\"], \"key\": \"gpu\"}, {\"value\": [\"swarm1567-c4\"], \"key\": \"id\"}, {\"value\": [\"chrome-trusty-18042300-b7223b463e3\"], \"key\": \"image\"}, {\"value\": [\"0\"], \"key\": \"inside_docker\"}, {\"value\": [\"1\"], \"key\": \"kvm\"}, {\"value\": [\"n1-standard-8\"], \"key\": \"machine_type\"}, {\"value\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"key\": \"os\"}, {\"value\": [\"luci.chromium.ci\"], \"key\": \"pool\"}, {\"value\": [\"2.7.6\"], \"key\": \"python\"}, {\"value\": [\"3551-c9816d0\"], \"key\": \"server_version\"}, {\"value\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"key\": \"zone\"}], \"try_number\": \"1\", \"current_task_slice\": \"0\", \"costs_usd\": [0.83784066058061368], \"bot_id\": \"swarm1567-c4\"}}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"jsonResult\": \"null\"}, \"recipeExitCode\": {\"value\": 0}, \"recipe\": {\"name\": \"chromium\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8946053745625073296/+/annotations\"}, \"ui\": {\"info\": \"\"}, \"properties\": {\"got_nacl_revision\": \"93deff44b49fcbb4da0ee7961f21b6b93da194e9\", \"swarm_hashes_refs/heads/master(at){#560186}\": {\"app_list_presenter_unittests\": \"0a603669acc544810340c6bc91d698daa11e49af\", \"crypto_unittests\": \"e2171b9fc98d231f9d2bc4a033e3efe3d65c6ab4\", \"google_apis_unittests\": \"8774966517e41d4f282d2193a94807d0dca62959\", \"compositor_unittests\": \"ed8d6527640e0707f73bd81800fe3321fd317c0a\", \"blink_heap_unittests\": \"2d67104f448965bd47c84848e72e64631e58833d\", \"ui_chromeos_unittests\": \"16f6d81e37fca3ad47395f320101f27eeadecfcf\", \"midi_unittests\": \"729881b17843fa008fd14825adcbb019b23a9a7f\", \"gpu_unittests\": \"2763c53f0695d3aafea66ad79280d9b41ce3926b\", \"base_unittests\": \"04b300318f8f445b2758aa8533b82fa38eae4eaf\", \"media_blink_unittests\": \"f091e7f40fe99d9014bae7bb2226f7b0ab2d043f\", \"app_list_unittests\": \"0c2599b950ea26dadcd6589bc4716d9d1391264d\", \"components_unittests\": \"5309f044aee39168fba8da4ba0fbbb2765c256ea\", \"sql_unittests\": \"5aed8a080f514db3ae2e0c150e5a3a20e8330c75\", \"latency_unittests\": \"98d1028bc4e904b7168b5bae36d1ad9b72fb71fc\", \"accessibility_unittests\": \"1ab0b667d793df3f92b5bfe76fb118227e102d11\", \"mojo_core_unittests\": \"621e9f75e638a6a3a2400b873657153235435bd5\", \"keyboard_unittests\": \"be4b59413976aab6d90f79b0cf50ecabe6473edd\", \"aura_unittests\": \"3d650c0189ca9960927e284ebeccfa3cbda014a2\", \"storage_unittests\": \"bb8f27053a373bdff9401700dc1194defee4e2b6\", \"jingle_unittests\": \"d57123f14b78188b3a315e960804c2c1d59bab1b\", \"webkit_unit_tests\": \"ad25e12f469fed9f9b9b746d6569d9d1e2a4b66b\", \"content_unittests\": \"49aa8aaa2606f0573eb97053405d88da4c51ab44\", \"ipc_tests\": \"bac08345b861f2a1da85540e24a113aba595fe3f\", \"remoting_unittests\": \"24316fddd7d1a2cdf0e966e7d3f1a880f3a814be\", \"events_unittests\": \"eecdd071ecda1d76d7c2181ea90fc4b5d90d96cb\", \"display_unittests\": \"327e75ce0fdac08230d9462abfe462ba29f5c1ca\", \"ash_unittests\": \"9602aa461eb24ebfd2df03ae8b2e7b5dbdf8c953\", \"content_browsertests\": \"739d4c5d2e8254568346b43b7770efafb0c762ae\", \"ui_touch_selection_unittests\": \"085bdc9e28445d5a62b08ae37782e52fff978afd\", \"capture_unittests\": \"3d88bbf1b02cb9c7038bfc7ce5f516a0473f1601\", \"cacheinvalidation_unittests\": \"ca67e443fdcacb98dd571408f9d15b227531bfc5\", \"viz_unittests\": \"eb0aac060f64a02b1698670b528c6907315ccac0\", \"wm_unittests\": \"6bda629c499b8e85a04011bb1f88518ea7d54de2\", \"chromeos_components_unittests\": \"dbb827fc1f2957b2ab4fe6a5307d97bd4248949f\", \"browser_tests\": \"5456920057a0f8a0867fbdf9f9557f84868ab2a3\", \"net_unittests\": \"faeee47548fdbfb20192b192f752b4203a559f1e\", \"pdf_unittests\": \"26d77f4c34a06ec4f303a4b0462455e8e9c05a41\", \"ash_content_unittests\": \"c0488b69fff1c238469e282ecf74f99f4e2c5f31\", \"nacl_helper_nonsfi_unittests\": \"4246060ef55e4c9c87783cf49c32e390cda2d4d4\", \"ppapi_unittests\": \"0e68d1b1d320cd0f9891a3d277ceab2fd120117d\", \"wtf_unittests\": \"a89ae56e2d8cefc2c71e310945846d38e428ddaf\", \"device_unittests\": \"9ab980b16937b687d2983961dac3e7928eeeac47\", \"extensions_unittests\": \"2ae54034ca6173dc0ad85e7344c6d1c14e96cd19\", \"nacl_loader_unittests\": \"262ad3b73806d28d75e407bcc7ac562b34aceeab\", \"app_shell_unittests\": \"67f0a5f9b610de444e82ece7f8ffaecf1fb473f2\", \"skia_unittests\": \"9ccdc6261bc2b8448d55fbf1b1810f6c62f2e893\", \"media_unittests\": \"f5818099e0c9a6117d1fa65641c17273b8e54178\", \"native_theme_unittests\": \"18517b7fb4011ee0970572226ebc75884cfabb12\", \"extensions_browsertests\": \"a0b382480a61db981883f0ede6690049f7063d8c\", \"chrome_app_unittests\": \"8ec2d85e793dbd215793ab55373cd56578eeec52\", \"interactive_ui_tests\": \"9e58c49865afdcfe9b0ab2c90c44fd5bfb8f90f3\", \"sync_integration_tests\": \"96ef9203bd85ae4504e3c14cce2e84aeb961b809\", \"unit_tests\": \"cfbd53d788214bd9a66a5e754684b1dc8fa0188e\", \"sandbox_linux_unittests\": \"ed5d256faaa647c586065600a28f1f8df0f937e9\", \"gcm_unit_tests\": \"5c483bb4c19f31bcdfdbe55fc31ee909a64ccd19\", \"message_center_unittests\": \"8b12cbc8006d4107993b01a435e1f66512a09c87\", \"views_unittests\": \"4a071cd4edd72b6fc669b3b30b23b55461ef652a\", \"url_unittests\": \"53868095fde9d8e60a266286686475a27f8f4ae5\", \"gfx_unittests\": \"95d98bf7ed9b7bba4572e04d5107cda37a49bd58\", \"media_service_unittests\": \"74d4f209849e3a580c0991f00210208f9aa93468\", \"services_unittests\": \"777186df479599c7c9d5b88240e785adbff98825\", \"chromeos_unittests\": \"8c5fc1d5123d4981b3c93f36d69f32972ba8ad2c\", \"ui_base_unittests\": \"873f20f7916488a00da8123bbf76f5b508eda8d7\"}, \"got_swarming_client_revision\": \"833f5ebf894be1e3e6d13678d5de8479bf12ff28\", \"got_revision\": \"aa324ebf0704d71f90c7bc9055120691481bc5b8\", \"recipe\": \"chromium\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#23315}\", \"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"got_revision_cp\": \"refs/heads/master@{#560186}\", \"branch\": \"refs/heads/master\", \"swarm_hashes\": {\"app_list_presenter_unittests\": \"0a603669acc544810340c6bc91d698daa11e49af\", \"crypto_unittests\": \"e2171b9fc98d231f9d2bc4a033e3efe3d65c6ab4\", \"google_apis_unittests\": \"8774966517e41d4f282d2193a94807d0dca62959\", \"compositor_unittests\": \"ed8d6527640e0707f73bd81800fe3321fd317c0a\", \"blink_heap_unittests\": \"2d67104f448965bd47c84848e72e64631e58833d\", \"ui_chromeos_unittests\": \"16f6d81e37fca3ad47395f320101f27eeadecfcf\", \"midi_unittests\": \"729881b17843fa008fd14825adcbb019b23a9a7f\", \"gpu_unittests\": \"2763c53f0695d3aafea66ad79280d9b41ce3926b\", \"base_unittests\": \"04b300318f8f445b2758aa8533b82fa38eae4eaf\", \"media_blink_unittests\": \"f091e7f40fe99d9014bae7bb2226f7b0ab2d043f\", \"app_list_unittests\": \"0c2599b950ea26dadcd6589bc4716d9d1391264d\", \"components_unittests\": \"5309f044aee39168fba8da4ba0fbbb2765c256ea\", \"sql_unittests\": \"5aed8a080f514db3ae2e0c150e5a3a20e8330c75\", \"latency_unittests\": \"98d1028bc4e904b7168b5bae36d1ad9b72fb71fc\", \"accessibility_unittests\": \"1ab0b667d793df3f92b5bfe76fb118227e102d11\", \"mojo_core_unittests\": \"621e9f75e638a6a3a2400b873657153235435bd5\", \"keyboard_unittests\": \"be4b59413976aab6d90f79b0cf50ecabe6473edd\", \"aura_unittests\": \"3d650c0189ca9960927e284ebeccfa3cbda014a2\", \"storage_unittests\": \"bb8f27053a373bdff9401700dc1194defee4e2b6\", \"jingle_unittests\": \"d57123f14b78188b3a315e960804c2c1d59bab1b\", \"webkit_unit_tests\": \"ad25e12f469fed9f9b9b746d6569d9d1e2a4b66b\", \"content_unittests\": \"49aa8aaa2606f0573eb97053405d88da4c51ab44\", \"ipc_tests\": \"bac08345b861f2a1da85540e24a113aba595fe3f\", \"remoting_unittests\": \"24316fddd7d1a2cdf0e966e7d3f1a880f3a814be\", \"events_unittests\": \"eecdd071ecda1d76d7c2181ea90fc4b5d90d96cb\", \"display_unittests\": \"327e75ce0fdac08230d9462abfe462ba29f5c1ca\", \"ash_unittests\": \"9602aa461eb24ebfd2df03ae8b2e7b5dbdf8c953\", \"content_browsertests\": \"739d4c5d2e8254568346b43b7770efafb0c762ae\", \"ui_touch_selection_unittests\": \"085bdc9e28445d5a62b08ae37782e52fff978afd\", \"capture_unittests\": \"3d88bbf1b02cb9c7038bfc7ce5f516a0473f1601\", \"cacheinvalidation_unittests\": \"ca67e443fdcacb98dd571408f9d15b227531bfc5\", \"viz_unittests\": \"eb0aac060f64a02b1698670b528c6907315ccac0\", \"wm_unittests\": \"6bda629c499b8e85a04011bb1f88518ea7d54de2\", \"chromeos_components_unittests\": \"dbb827fc1f2957b2ab4fe6a5307d97bd4248949f\", \"browser_tests\": \"5456920057a0f8a0867fbdf9f9557f84868ab2a3\", \"net_unittests\": \"faeee47548fdbfb20192b192f752b4203a559f1e\", \"pdf_unittests\": \"26d77f4c34a06ec4f303a4b0462455e8e9c05a41\", \"ash_content_unittests\": \"c0488b69fff1c238469e282ecf74f99f4e2c5f31\", \"nacl_helper_nonsfi_unittests\": \"4246060ef55e4c9c87783cf49c32e390cda2d4d4\", \"ppapi_unittests\": \"0e68d1b1d320cd0f9891a3d277ceab2fd120117d\", \"wtf_unittests\": \"a89ae56e2d8cefc2c71e310945846d38e428ddaf\", \"device_unittests\": \"9ab980b16937b687d2983961dac3e7928eeeac47\", \"extensions_unittests\": \"2ae54034ca6173dc0ad85e7344c6d1c14e96cd19\", \"nacl_loader_unittests\": \"262ad3b73806d28d75e407bcc7ac562b34aceeab\", \"app_shell_unittests\": \"67f0a5f9b610de444e82ece7f8ffaecf1fb473f2\", \"skia_unittests\": \"9ccdc6261bc2b8448d55fbf1b1810f6c62f2e893\", \"media_unittests\": \"f5818099e0c9a6117d1fa65641c17273b8e54178\", \"native_theme_unittests\": \"18517b7fb4011ee0970572226ebc75884cfabb12\", \"extensions_browsertests\": \"a0b382480a61db981883f0ede6690049f7063d8c\", \"chrome_app_unittests\": \"8ec2d85e793dbd215793ab55373cd56578eeec52\", \"interactive_ui_tests\": \"9e58c49865afdcfe9b0ab2c90c44fd5bfb8f90f3\", \"sync_integration_tests\": \"96ef9203bd85ae4504e3c14cce2e84aeb961b809\", \"unit_tests\": \"cfbd53d788214bd9a66a5e754684b1dc8fa0188e\", \"sandbox_linux_unittests\": \"ed5d256faaa647c586065600a28f1f8df0f937e9\", \"gcm_unit_tests\": \"5c483bb4c19f31bcdfdbe55fc31ee909a64ccd19\", \"message_center_unittests\": \"8b12cbc8006d4107993b01a435e1f66512a09c87\", \"views_unittests\": \"4a071cd4edd72b6fc669b3b30b23b55461ef652a\", \"url_unittests\": \"53868095fde9d8e60a266286686475a27f8f4ae5\", \"gfx_unittests\": \"95d98bf7ed9b7bba4572e04d5107cda37a49bd58\", \"media_service_unittests\": \"74d4f209849e3a580c0991f00210208f9aa93468\", \"services_unittests\": \"777186df479599c7c9d5b88240e785adbff98825\", \"chromeos_unittests\": \"8c5fc1d5123d4981b3c93f36d69f32972ba8ad2c\", \"ui_base_unittests\": \"873f20f7916488a00da8123bbf76f5b508eda8d7\"}, \"got_buildtools_revision\": \"94288c26d2ffe3aec9848c147839afee597acefd\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"linux-chromeos-dbg\", \"got_webrtc_revision\": \"a832019f4e3ac11544f1497368a16a3a525e2932\", \"mastername\": \"chromium.chromiumos\", \"$recipe_engine/runtime\": {\"is_experimental\": true, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1526775331815530, \"tags\": [\"builder:linux-chromeos-dbg\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa324ebf0704d71f90c7bc9055120691481bc5b8\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9111483807936361376\", \"scheduler_job_id:chromium/linux-chromeos-dbg\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.chromium.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"chromium\", \"id\": \"8946053745625073296\"}}, \"got_v8_revision\": \"b292e56ef7ebd196432feed93aeb4939df57edc9\", \"got_v8_revision_cp\": \"refs/heads/6.8.260@{#1}\", \"got_angle_revision\": \"9b1a908452916e90856b51bc014cc969230ff152\", \"buildnumber\": 45, \"path_config\": \"generic\", \"revision\": \"aa324ebf0704d71f90c7bc9055120691481bc5b8\", \"bot_id\": \"swarm1567-c4\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1526775345606290",
"status": "COMPLETED",
"status_changed_ts": "1526782680912570",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/45",
"builder:linux-chromeos-dbg",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa324ebf0704d71f90c7bc9055120691481bc5b8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9111483807936361376",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_dimension:builder:linux-chromeos-dbg",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Ubuntu-14.04",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/linux-chromeos-dbg/45",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8946053745625073296",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:06be006c935279af3663102925cce4dcc526e425",
"swarming_tag:builder:linux-chromeos-dbg",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aa324ebf0704d71f90c7bc9055120691481bc5b8",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8946053745625073296/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Ubuntu-14.04",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:60",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9111483807936361376",
"swarming_tag:scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3d93b848768d7c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1526782680914860",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/linux-chromeos-dbg/45",
"utcnow_ts": "1526782681909070"
}
}
[02:18:02.004] Invocation finished in 2h2m31.77716942s with status SUCCEEDED