[16:59:11.291] New invocation is queued and will start shortly
[16:59:12.352] Starting the invocation (attempt 1)
[16:59:12.391] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:59:12.391] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:59:12.391] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023632201147755984",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"470d2dcadda09854ed3cb5d80b2dd4b9a628a909\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9023632201147755984",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/470d2dcadda09854ed3cb5d80b2dd4b9a628a909",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/470d2dcadda09854ed3cb5d80b2dd4b9a628a909",
"gitiles_ref:refs/heads/master"
]
}
[16:59:12.981] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610557152467789",
"id": "8858202139253450336",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"470d2dcadda09854ed3cb5d80b2dd4b9a628a909\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610557152871179",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22185",
"builder:linux-chromeos-dbg",
"buildset:commit/git/470d2dcadda09854ed3cb5d80b2dd4b9a628a909",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/470d2dcadda09854ed3cb5d80b2dd4b9a628a909",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023632201147755984",
"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/8858202139253450336/+/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": "1610557152871350",
"url": "https://ci.chromium.org/b/8858202139253450336",
"utcnow_ts": "1610557152974199"
}
}
[16:59:12.981] Task URL: https://ci.chromium.org/b/8858202139253450336
[16:59:12.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:2:0) after 1m0s
[16:59:30.348] Received PubSub notification, asking Buildbucket for the build status
[16:59:30.435] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:13.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:2:0)
[17:00:13.082] Timer tick, asking Buildbucket for the build status
[17:00:13.266] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:13.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:4:0) after 1m0s
[17:01:13.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:4:0)
[17:01:13.365] Timer tick, asking Buildbucket for the build status
[17:01:13.495] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:13.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:5:0) after 1m0s
[17:02:13.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:5:0)
[17:02:13.619] Timer tick, asking Buildbucket for the build status
[17:02:13.734] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:13.734] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:6:0) after 1m0s
[17:03:13.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:6:0)
[17:03:13.834] Timer tick, asking Buildbucket for the build status
[17:03:13.896] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:13.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:7:0) after 1m0s
[17:04:13.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:7:0)
[17:04:13.926] Timer tick, asking Buildbucket for the build status
[17:04:14.079] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:14.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:8:0) after 1m0s
[17:05:14.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:8:0)
[17:05:14.146] Timer tick, asking Buildbucket for the build status
[17:05:14.299] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:14.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:9:0) after 1m0s
[17:06:14.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:9:0)
[17:06:14.323] Timer tick, asking Buildbucket for the build status
[17:06:14.445] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:14.446] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:10:0) after 1m0s
[17:07:14.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:10:0)
[17:07:14.488] Timer tick, asking Buildbucket for the build status
[17:07:14.738] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:14.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:11:0) after 1m0s
[17:08:15.052] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:11:0)
[17:08:15.052] Timer tick, asking Buildbucket for the build status
[17:08:15.157] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:15.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:12:0) after 1m0s
[17:09:15.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:12:0)
[17:09:15.444] Timer tick, asking Buildbucket for the build status
[17:09:15.608] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:15.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:13:0) after 1m0s
[17:10:15.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:13:0)
[17:10:15.682] Timer tick, asking Buildbucket for the build status
[17:10:15.822] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:15.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:14:0) after 1m0s
[17:11:15.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:14:0)
[17:11:15.843] Timer tick, asking Buildbucket for the build status
[17:11:16.036] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:16.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:15:0) after 1m0s
[17:12:16.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:15:0)
[17:12:16.105] Timer tick, asking Buildbucket for the build status
[17:12:16.154] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:16.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:16:0) after 1m0s
[17:13:16.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:16:0)
[17:13:16.231] Timer tick, asking Buildbucket for the build status
[17:13:16.402] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:16.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:17:0) after 1m0s
[17:14:16.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:17:0)
[17:14:16.571] Timer tick, asking Buildbucket for the build status
[17:14:17.306] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:17.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:18:0) after 1m0s
[17:15:17.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:18:0)
[17:15:17.381] Timer tick, asking Buildbucket for the build status
[17:15:17.468] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:17.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:19:0) after 1m0s
[17:16:17.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:19:0)
[17:16:17.558] Timer tick, asking Buildbucket for the build status
[17:16:17.761] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:17.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:20:0) after 1m0s
[17:17:17.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:20:0)
[17:17:17.793] Timer tick, asking Buildbucket for the build status
[17:17:18.145] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:18.145] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:21:0) after 1m0s
[17:18:18.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:21:0)
[17:18:18.298] Timer tick, asking Buildbucket for the build status
[17:18:23.752] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:23.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:22:0) after 1m0s
[17:19:23.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:22:0)
[17:19:23.848] Timer tick, asking Buildbucket for the build status
[17:19:23.971] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:23.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:23:0) after 1m0s
[17:20:24.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:23:0)
[17:20:24.043] Timer tick, asking Buildbucket for the build status
[17:20:24.460] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:24.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:24:0) after 1m0s
[17:21:24.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:24:0)
[17:21:24.468] Timer tick, asking Buildbucket for the build status
[17:21:24.544] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:24.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:25:0) after 1m0s
[17:22:24.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:25:0)
[17:22:24.559] Timer tick, asking Buildbucket for the build status
[17:22:24.632] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:24.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:26:0) after 1m0s
[17:23:24.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:26:0)
[17:23:24.626] Timer tick, asking Buildbucket for the build status
[17:23:24.719] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:24.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:27:0) after 1m0s
[17:24:24.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:27:0)
[17:24:24.743] Timer tick, asking Buildbucket for the build status
[17:24:24.915] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:24.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:28:0) after 1m0s
[17:25:25.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:28:0)
[17:25:25.514] Timer tick, asking Buildbucket for the build status
[17:25:25.791] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:25.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:29:0) after 1m0s
[17:26:26.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:29:0)
[17:26:26.332] Timer tick, asking Buildbucket for the build status
[17:26:26.429] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:26.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:30:0) after 1m0s
[17:27:27.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:30:0)
[17:27:27.015] Timer tick, asking Buildbucket for the build status
[17:27:27.184] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:27.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:31:0) after 1m0s
[17:28:27.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:31:0)
[17:28:27.311] Timer tick, asking Buildbucket for the build status
[17:28:27.387] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:27.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:32:0) after 1m0s
[17:29:27.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:32:0)
[17:29:27.426] Timer tick, asking Buildbucket for the build status
[17:29:27.912] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:27.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:33:0) after 1m0s
[17:30:27.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:33:0)
[17:30:27.967] Timer tick, asking Buildbucket for the build status
[17:30:28.375] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:28.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:34:0) after 1m0s
[17:31:28.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:34:0)
[17:31:28.452] Timer tick, asking Buildbucket for the build status
[17:31:28.558] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:28.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:35:0) after 1m0s
[17:32:28.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:35:0)
[17:32:28.623] Timer tick, asking Buildbucket for the build status
[17:32:28.693] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:28.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:36:0) after 1m0s
[17:33:28.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:36:0)
[17:33:28.833] Timer tick, asking Buildbucket for the build status
[17:33:28.990] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:28.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:37:0) after 1m0s
[17:34:29.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:37:0)
[17:34:29.268] Timer tick, asking Buildbucket for the build status
[17:34:29.991] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:29.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:38:0) after 1m0s
[17:35:30.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:38:0)
[17:35:30.283] Timer tick, asking Buildbucket for the build status
[17:35:30.668] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:30.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:39:0) after 1m0s
[17:36:30.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:39:0)
[17:36:30.752] Timer tick, asking Buildbucket for the build status
[17:36:31.986] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:31.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:40:0) after 1m0s
[17:37:32.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:40:0)
[17:37:32.095] Timer tick, asking Buildbucket for the build status
[17:37:32.204] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:32.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:41:0) after 1m0s
[17:38:32.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:41:0)
[17:38:32.299] Timer tick, asking Buildbucket for the build status
[17:38:32.362] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:32.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:42:0) after 1m0s
[17:39:32.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:42:0)
[17:39:32.355] Timer tick, asking Buildbucket for the build status
[17:39:33.124] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:33.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:43:0) after 1m0s
[17:40:33.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:43:0)
[17:40:33.200] Timer tick, asking Buildbucket for the build status
[17:40:33.267] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:33.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:44:0) after 1m0s
[17:41:33.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:44:0)
[17:41:33.374] Timer tick, asking Buildbucket for the build status
[17:41:33.427] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:33.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:45:0) after 1m0s
[17:42:33.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:45:0)
[17:42:33.492] Timer tick, asking Buildbucket for the build status
[17:42:33.604] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:33.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:46:0) after 1m0s
[17:43:33.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:46:0)
[17:43:33.579] Timer tick, asking Buildbucket for the build status
[17:43:33.709] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:33.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:47:0) after 1m0s
[17:44:33.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:47:0)
[17:44:33.685] Timer tick, asking Buildbucket for the build status
[17:44:33.789] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:33.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:48:0) after 1m0s
[17:45:33.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:48:0)
[17:45:33.874] Timer tick, asking Buildbucket for the build status
[17:45:34.178] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:34.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:49:0) after 1m0s
[17:46:34.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:49:0)
[17:46:34.186] Timer tick, asking Buildbucket for the build status
[17:46:34.244] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:34.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:50:0) after 1m0s
[17:47:34.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:50:0)
[17:47:34.265] Timer tick, asking Buildbucket for the build status
[17:47:34.647] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:34.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:51:0) after 1m0s
[17:48:35.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:51:0)
[17:48:35.090] Timer tick, asking Buildbucket for the build status
[17:48:35.236] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:35.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:52:0) after 1m0s
[17:49:35.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:52:0)
[17:49:35.407] Timer tick, asking Buildbucket for the build status
[17:49:35.535] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:35.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:53:0) after 1m0s
[17:50:35.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:53:0)
[17:50:35.602] Timer tick, asking Buildbucket for the build status
[17:50:35.672] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:35.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:54:0) after 1m0s
[17:51:35.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:54:0)
[17:51:35.806] Timer tick, asking Buildbucket for the build status
[17:51:35.882] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:35.882] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:55:0) after 1m0s
[17:52:35.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:55:0)
[17:52:35.919] Timer tick, asking Buildbucket for the build status
[17:52:36.002] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:36.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:56:0) after 1m0s
[17:53:36.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:56:0)
[17:53:36.025] Timer tick, asking Buildbucket for the build status
[17:53:36.088] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:36.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:57:0) after 1m0s
[17:54:36.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:57:0)
[17:54:36.356] Timer tick, asking Buildbucket for the build status
[17:54:36.499] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:36.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:58:0) after 1m0s
[17:55:36.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:58:0)
[17:55:36.547] Timer tick, asking Buildbucket for the build status
[17:55:37.032] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:37.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:59:0) after 1m0s
[17:56:37.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:59:0)
[17:56:37.126] Timer tick, asking Buildbucket for the build status
[17:56:37.299] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:37.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:60:0) after 1m0s
[17:57:37.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:60:0)
[17:57:37.333] Timer tick, asking Buildbucket for the build status
[17:57:37.473] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:37.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:61:0) after 1m0s
[17:58:37.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:61:0)
[17:58:37.474] Timer tick, asking Buildbucket for the build status
[17:58:37.677] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:37.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:62:0) after 1m0s
[17:59:37.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:62:0)
[17:59:37.698] Timer tick, asking Buildbucket for the build status
[17:59:37.873] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:37.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:63:0) after 1m0s
[18:00:37.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:63:0)
[18:00:37.972] Timer tick, asking Buildbucket for the build status
[18:00:38.199] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:38.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:64:0) after 1m0s
[18:01:38.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:64:0)
[18:01:38.352] Timer tick, asking Buildbucket for the build status
[18:01:38.522] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:38.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:65:0) after 1m0s
[18:02:38.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:65:0)
[18:02:38.589] Timer tick, asking Buildbucket for the build status
[18:02:38.765] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:38.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:66:0) after 1m0s
[18:03:38.861] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:66:0)
[18:03:38.861] Timer tick, asking Buildbucket for the build status
[18:03:38.995] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:38.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:67:0) after 1m0s
[18:04:39.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:67:0)
[18:04:39.170] Timer tick, asking Buildbucket for the build status
[18:04:39.418] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:39.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:68:0) after 1m0s
[18:05:39.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:68:0)
[18:05:39.482] Timer tick, asking Buildbucket for the build status
[18:05:39.603] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:39.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:69:0) after 1m0s
[18:06:39.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:69:0)
[18:06:39.631] Timer tick, asking Buildbucket for the build status
[18:06:39.791] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:39.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:70:0) after 1m0s
[18:07:39.916] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:70:0)
[18:07:39.916] Timer tick, asking Buildbucket for the build status
[18:07:40.091] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:40.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:71:0) after 1m0s
[18:08:40.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:71:0)
[18:08:40.143] Timer tick, asking Buildbucket for the build status
[18:08:40.285] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:40.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:72:0) after 1m0s
[18:09:40.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:72:0)
[18:09:40.338] Timer tick, asking Buildbucket for the build status
[18:09:40.697] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:40.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:73:0) after 1m0s
[18:10:40.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:73:0)
[18:10:40.851] Timer tick, asking Buildbucket for the build status
[18:10:40.993] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:40.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:74:0) after 1m0s
[18:11:41.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:74:0)
[18:11:41.073] Timer tick, asking Buildbucket for the build status
[18:11:41.149] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:41.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:75:0) after 1m0s
[18:12:41.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:75:0)
[18:12:41.145] Timer tick, asking Buildbucket for the build status
[18:12:41.257] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:41.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:76:0) after 1m0s
[18:13:41.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:76:0)
[18:13:41.439] Timer tick, asking Buildbucket for the build status
[18:13:41.774] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:41.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:77:0) after 1m0s
[18:14:41.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:77:0)
[18:14:41.824] Timer tick, asking Buildbucket for the build status
[18:14:41.990] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:41.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:78:0) after 1m0s
[18:15:42.180] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:78:0)
[18:15:42.180] Timer tick, asking Buildbucket for the build status
[18:15:42.256] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:42.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:79:0) after 1m0s
[18:16:42.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:79:0)
[18:16:42.376] Timer tick, asking Buildbucket for the build status
[18:16:42.519] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:42.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:80:0) after 1m0s
[18:17:42.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:80:0)
[18:17:42.618] Timer tick, asking Buildbucket for the build status
[18:17:42.737] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:42.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:81:0) after 1m0s
[18:18:42.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:81:0)
[18:18:42.774] Timer tick, asking Buildbucket for the build status
[18:18:43.103] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:43.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:82:0) after 1m0s
[18:19:43.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:82:0)
[18:19:43.242] Timer tick, asking Buildbucket for the build status
[18:19:43.804] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:43.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:83:0) after 1m0s
[18:20:43.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:83:0)
[18:20:43.891] Timer tick, asking Buildbucket for the build status
[18:20:44.122] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:44.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:84:0) after 1m0s
[18:21:44.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:84:0)
[18:21:44.163] Timer tick, asking Buildbucket for the build status
[18:21:44.399] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:44.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:85:0) after 1m0s
[18:22:44.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:85:0)
[18:22:44.474] Timer tick, asking Buildbucket for the build status
[18:22:44.587] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:44.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:86:0) after 1m0s
[18:23:44.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:86:0)
[18:23:44.602] Timer tick, asking Buildbucket for the build status
[18:23:44.979] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:44.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:87:0) after 1m0s
[18:24:44.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:87:0)
[18:24:44.986] Timer tick, asking Buildbucket for the build status
[18:24:45.170] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:45.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:88:0) after 1m0s
[18:25:45.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:88:0)
[18:25:45.204] Timer tick, asking Buildbucket for the build status
[18:25:45.552] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:45.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:89:0) after 1m0s
[18:26:45.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:89:0)
[18:26:45.627] Timer tick, asking Buildbucket for the build status
[18:26:46.559] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:46.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:90:0) after 1m0s
[18:27:46.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:90:0)
[18:27:46.569] Timer tick, asking Buildbucket for the build status
[18:27:46.807] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:46.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:91:0) after 1m0s
[18:28:46.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:91:0)
[18:28:46.831] Timer tick, asking Buildbucket for the build status
[18:28:46.917] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:46.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:92:0) after 1m0s
[18:29:46.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:92:0)
[18:29:46.958] Timer tick, asking Buildbucket for the build status
[18:29:47.161] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:47.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:93:0) after 1m0s
[18:30:47.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:93:0)
[18:30:47.253] Timer tick, asking Buildbucket for the build status
[18:30:47.348] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:47.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:94:0) after 1m0s
[18:31:47.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:94:0)
[18:31:47.384] Timer tick, asking Buildbucket for the build status
[18:31:47.540] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:47.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:95:0) after 1m0s
[18:32:47.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:95:0)
[18:32:47.563] Timer tick, asking Buildbucket for the build status
[18:32:47.679] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:47.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:96:0) after 1m0s
[18:33:47.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:96:0)
[18:33:47.681] Timer tick, asking Buildbucket for the build status
[18:33:47.813] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:47.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:97:0) after 1m0s
[18:34:47.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:97:0)
[18:34:47.862] Timer tick, asking Buildbucket for the build status
[18:34:48.208] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:48.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:98:0) after 1m0s
[18:35:48.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:98:0)
[18:35:48.238] Timer tick, asking Buildbucket for the build status
[18:35:48.505] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:48.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:99:0) after 1m0s
[18:36:48.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:99:0)
[18:36:48.514] Timer tick, asking Buildbucket for the build status
[18:36:48.662] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:48.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:100:0) after 1m0s
[18:37:48.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:100:0)
[18:37:48.712] Timer tick, asking Buildbucket for the build status
[18:37:48.899] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:48.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:101:0) after 1m0s
[18:38:48.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:101:0)
[18:38:48.924] Timer tick, asking Buildbucket for the build status
[18:38:49.009] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:49.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:102:0) after 1m0s
[18:39:49.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:102:0)
[18:39:49.033] Timer tick, asking Buildbucket for the build status
[18:39:49.173] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:49.173] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:103:0) after 1m0s
[18:40:49.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:103:0)
[18:40:49.196] Timer tick, asking Buildbucket for the build status
[18:40:49.296] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:49.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:104:0) after 1m0s
[18:41:49.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:104:0)
[18:41:49.307] Timer tick, asking Buildbucket for the build status
[18:41:49.522] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:49.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:105:0) after 1m0s
[18:42:49.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:105:0)
[18:42:49.545] Timer tick, asking Buildbucket for the build status
[18:42:49.937] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:49.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:106:0) after 1m0s
[18:43:49.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:106:0)
[18:43:49.923] Timer tick, asking Buildbucket for the build status
[18:43:50.105] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:50.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:107:0) after 1m0s
[18:44:50.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:107:0)
[18:44:50.099] Timer tick, asking Buildbucket for the build status
[18:44:50.234] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:50.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:108:0) after 1m0s
[18:45:50.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:108:0)
[18:45:50.272] Timer tick, asking Buildbucket for the build status
[18:45:50.473] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:50.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:109:0) after 1m0s
[18:46:50.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:109:0)
[18:46:50.506] Timer tick, asking Buildbucket for the build status
[18:46:50.579] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:50.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:110:0) after 1m0s
[18:47:50.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:110:0)
[18:47:50.661] Timer tick, asking Buildbucket for the build status
[18:47:51.153] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:51.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:111:0) after 1m0s
[18:48:51.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:111:0)
[18:48:51.232] Timer tick, asking Buildbucket for the build status
[18:48:51.749] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:51.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:112:0) after 1m0s
[18:49:51.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:112:0)
[18:49:51.959] Timer tick, asking Buildbucket for the build status
[18:49:52.100] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:52.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:113:0) after 1m0s
[18:50:52.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:113:0)
[18:50:52.234] Timer tick, asking Buildbucket for the build status
[18:50:52.383] Build 8858202139253450336: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:52.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023632201147755984:114:0) after 1m0s
[18:51:03.682] Received PubSub notification, asking Buildbucket for the build status
[18:51:03.789] Build 8858202139253450336: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:51:03.789] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610563862718559",
"created_by": "project:chromium",
"created_ts": "1610557152467789",
"id": "8858202139253450336",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"470d2dcadda09854ed3cb5d80b2dd4b9a628a909\"}}",
"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\": \"470d2dcadda09854ed3cb5d80b2dd4b9a628a909\", \"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-159-iph3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22185, \"got_angle_revision\": \"62b8364eafc717bfa9c35af5304b7ad5959e7134\", \"got_dawn_revision\": \"111ba65a5e3dbd23a58dd63991e92e9300f44d13\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"470d2dcadda09854ed3cb5d80b2dd4b9a628a909\", \"got_revision_cp\": \"refs/heads/master@{#843049}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"3549479dc4ccd92ef3b9e179080dcec1a430b01d\", \"got_v8_revision\": \"6cbcce5b4a6305bfc281c520ca0d24fa6d0c9a39\", \"got_v8_revision_cp\": \"refs/heads/8.9.262@{#1}\", \"got_webrtc_revision\": \"1c5e63e5451374783aaf0259f5c23d3688a5b2ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32938}\", \"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\": \"470d2dcadda09854ed3cb5d80b2dd4b9a628a909\", \"swarm_hashes_refs/heads/master(at){#843049}_without_patch\": {\"absl_hardening_tests\": \"98398d05fa61c2eb78971200c2421c0ddb674610\", \"accessibility_unittests\": \"a3ebe7f4ee13bc6265f4eca1daf4697eca8a957d\", \"angle_unittests\": \"b9702d4c1e9211e5f7fbfa8b2a9df7ef7704fae4\", \"app_list_unittests\": \"02a484c0c70614c28646ba89e7eca4d93ddd55c3\", \"app_shell_unittests\": \"f2a8987829e900305546523c9af2d54dde1574fa\", \"ash_unittests\": \"c2b440a6f81993508f80e4bb4a77aaa15c140999\", \"aura_unittests\": \"bc587fa53f8277465209791ee4dd638603ee7c6d\", \"base_unittests\": \"2ed52d00e868f5c3d87b23129480de39790f7b4c\", \"base_util_unittests\": \"d8846fc8d49ebd62f47d5ff98d62e4cb2ac3bd3c\", \"blink_common_unittests\": \"375c7ec928ec89bc9ef6e650844890b37d59bfcb\", \"blink_fuzzer_unittests\": \"be15c40ab7292cb2c43d9aceebd98548fdac1b42\", \"blink_heap_unittests\": \"d25f8a28666b90a1c5f6985337489f28fe10ef74\", \"blink_platform_unittests\": \"3ddead0a08b0095ca02391cab72797de6287881d\", \"blink_unittests\": \"f399b03f2441e59baf90930451b90740e44ab690\", \"boringssl_crypto_tests\": \"1e855d2c9caae37da75ff384ee862cf1a08eede8\", \"boringssl_ssl_tests\": \"d9d004009a242118d32db3fa26b266a99e9e28cf\", \"browser_tests\": \"439100ae7a7e73b1aaa6a81359faf7d77d8d21d4\", \"capture_unittests\": \"baadece8f4ae534a92492fef8aef6c57d1020ce9\", \"cast_unittests\": \"879e72fe0928f884a1c362c2f05c524282f76be4\", \"cc_unittests\": \"7cdf32a0f9f73e47edbe96fd3c055af701c0725c\", \"chrome_app_unittests\": \"4d09f5baf37c6611c89d867dcc7d7f5da98851cc\", \"chromedriver_unittests\": \"46a8245e915166e7ce36bc4bb83ef4903fce673e\", \"chromeos_components_unittests\": \"abad01ac18338aa519dc342ebad45e4e7526c0e7\", \"chromeos_unittests\": \"5104cdc18c4bf53658914076091fa7784126bc85\", \"components_browsertests\": \"15af3c42244e01575be646450deb3dc78a983b52\", \"components_unittests\": \"0e17668d70eb88752e5d2ddf18f8dfa61bd20a82\", \"compositor_unittests\": \"b47c466390272292d011f446302bd099e1d08a25\", \"content_browsertests\": \"f8292b6c1ec05977c7232da548898619053b36d8\", \"content_unittests\": \"c696ff0955e1ac8509eed4ee5756a59ec993d7f2\", \"crashpad_tests\": \"179125259e714b9473a21cacc8f7aae751572695\", \"crypto_unittests\": \"16af8e4129c62f1771c72385e5c4732c2c662c1e\", \"dbus_unittests\": \"34c89146386a115c460aca9058af83f12eeca728\", \"device_unittests\": \"6d859092f62de373bcca10e2fc1c33b444b86dab\", \"display_unittests\": \"6f550cccb55dc830d12f0ecf1a6a0e92ab1546cb\", \"events_unittests\": \"bdf926adf41b8cf81289ca5b564eaf99df9b7085\", \"exo_unittests\": \"9a33a8a7720976d8c707d056a0e107e112057a4f\", \"extensions_browsertests\": \"58cc0a137bcb63031b6caa36ff482cd01cd266dd\", \"extensions_unittests\": \"7944cd0ac2e343c5a4b7eaf81694c752a75ff447\", \"filesystem_service_unittests\": \"af9fee24b1ea0bd7b4508a0fda051a367e346490\", \"gcm_unit_tests\": \"7d308089c70f5046961f27613e906d2542dc9e7c\", \"gfx_unittests\": \"d90ae4002ca3a0da44edf4ffcb5feb536c5e2d32\", \"gin_unittests\": \"8a12451448fbb483dc5cc18d907fecf2b36fe0fe\", \"gl_unittests_ozone\": \"1eb735d92fce36b6d962591f50f778420246bf39\", \"google_apis_unittests\": \"7ac39e8863ac0edf19287a7811c00d098e1bd425\", \"gpu_unittests\": \"a40d47186acc92875592688c665fbeebb2ea3543\", \"gwp_asan_unittests\": \"803b592396200f6c09c0a0cd11ab80fdea20b29b\", \"interactive_ui_tests\": \"94938a7ff300a1e3385fa7818f878f7485f05362\", \"ipc_tests\": \"88b497bb40d028e349734ac7c33b9aa797b946d8\", \"jingle_unittests\": \"56852ca93b7eb25a09a518d24e3cabb67331d768\", \"keyboard_unittests\": \"0baf125fc5db3f3a7dbb93d00dc4ed2e8222f680\", \"latency_unittests\": \"aecee56ffac3646e0de17c7febdf844f6890b559\", \"libjingle_xmpp_unittests\": \"c6c55b7714266ac5dd7d0567053a1133082e8691\", \"liburlpattern_unittests\": \"5d14443d292575cf06f17d0c03548c505e3f7db0\", \"media_blink_unittests\": \"a2bf7f3e4419e79a18698884daa108ac5c371a6d\", \"media_unittests\": \"5bf77ba020d0c89c3a4d79e0f14eaca4b52dbd5c\", \"message_center_unittests\": \"4f4da3a24eb95d6caeb48b62b1a447b2776f052a\", \"midi_unittests\": \"5c071529e305f5931431a932ec52d6450558d897\", \"mojo_core_unittests\": \"efd6867bdfab8110cb9c7b5f325a6106281ddd0a\", \"mojo_unittests\": \"dc4e09efe5458ce266571e5c0fff9db6aa77502a\", \"nacl_helper_nonsfi_unittests\": \"056deb60b5754f9e42b70d979f9827043fe830c0\", \"nacl_loader_unittests\": \"c98dcf89405504a03bdfa8e6ca4efd8b13330ec3\", \"native_theme_unittests\": \"7f5cdb51edc1f71af87ed46a97b69611edf036ca\", \"net_unittests\": \"62d780817e1a38785532ec5729dbda685e6a5f7a\", \"ozone_gl_unittests\": \"03df7a8e6885d811e4d13902228a1b7c8e63cd01\", \"ozone_unittests\": \"d71eebfab91890422b04b88c2be34592f0dd66ef\", \"ozone_x11_unittests\": \"d48664f0a98268fdcf6466a4ab37a41ae9da8032\", \"pdf_unittests\": \"1147891029b7c39e6ae6d7d8bb6e5538c197ad5b\", \"perfetto_unittests\": \"d598296a58c7e9d6166be7ac829a3e7f9743d951\", \"ppapi_unittests\": \"04e15102444c2d54c93caea5a6e68d32b084eb0b\", \"printing_unittests\": \"0a9f92ebd9425aca818f911cf4fc5224a68a8212\", \"remoting_unittests\": \"cf3f829067d3579287667c7ed8580d4cbe648cdf\", \"sandbox_linux_unittests\": \"667a0634cc405550651e7373fccdb8361bb50260\", \"service_manager_unittests\": \"b5f12d1b17acbd4137d0c380b97db76f0655a8ca\", \"services_unittests\": \"8de3732ef16d936f81a3839fb0b6ff9440179683\", \"shell_dialogs_unittests\": \"22fe11eb3e581786d69e01dbd0470e50ce709a2d\", \"shell_encryption_unittests\": \"216b9cd1e991d8c127134a67070a2769f6fee44e\", \"skia_unittests\": \"051f76a0113df285defffebe8536357b11eb05c3\", \"snapshot_unittests\": \"089b2ab425572e2ee9d23ae0a036ce43f75412d1\", \"sql_unittests\": \"9058757f1f751ac5ece5770f931ecfb4a911ffdb\", \"storage_unittests\": \"15238aff477677b25c9a04e6dd5fb9e0f2d946ce\", \"sync_integration_tests\": \"cd352ec432814b8cd1736b7906ac169dba00ee23\", \"traffic_annotation_auditor_unittests\": \"d1f7481e505977ed7fa41c6e32f8ba9a35628bf0\", \"ui_base_unittests\": \"d290405d9841e953abdaaea040e2024afff03742\", \"ui_chromeos_unittests\": \"49adf657909edc1e8b85efa6e5607087dc608a57\", \"ui_touch_selection_unittests\": \"4ee905fb8201c3315012c8165d1d1ea9589f68bf\", \"unit_tests\": \"547adc0813bd0a4f63e7e976b37af995d0fc5d03\", \"url_unittests\": \"74091864d4aff6dd3f9e62406be3ac0dac83dcb0\", \"usage_time_limit_unittests\": \"cab68cce960d4db692e3e8e846b47a713fd328fb\", \"views_unittests\": \"4c73a353699364cee4fd4c5b96802ab6f18e29c4\", \"viz_unittests\": \"0f6ad77b87265f7accf1ef6e5be84b95d98c411d\", \"wm_unittests\": \"5067a1063f3a0b53b82c9c3f31d792c27015720a\", \"wtf_unittests\": \"4b3f943db7f10cf639cfa6ff749aa449c4292536\", \"zlib_unittests\": \"1cbe7044d08a3ede21186aefb63d470d6e2ec19e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3f701152d865ce3ec8feb15f973214ad980aeace5cbda24477548a965269fca6_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_7b27d20986eac2bbcc1513665f8799c69dbe398236c21423fd80a70475184e3c_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-159-iph3\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"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\": [\"5661-c6f6250\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610557169614093",
"status": "COMPLETED",
"status_changed_ts": "1610563863133474",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22185",
"builder:linux-chromeos-dbg",
"buildset:commit/git/470d2dcadda09854ed3cb5d80b2dd4b9a628a909",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/470d2dcadda09854ed3cb5d80b2dd4b9a628a909",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023632201147755984",
"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/8858202139253450336/+/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:51158167a3ffd710",
"user_agent:luci-scheduler"
],
"updated_ts": "1610563863137652",
"url": "https://ci.chromium.org/b/8858202139253450336",
"utcnow_ts": "1610563863772555"
}
}
[18:51:03.789] Invocation finished in 1h51m52.513807205s with status SUCCEEDED