[08:20:58.356] New invocation is queued and will start shortly
[08:20:59.533] Starting the invocation (attempt 1)
[08:20:59.577] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:20:59.577] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:20:59.577] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018500777379824464",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d3f3dfdb1034bdfb6a522c0dae9f1d9d39a8cd6f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9018500777379824464",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/d3f3dfdb1034bdfb6a522c0dae9f1d9d39a8cd6f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d3f3dfdb1034bdfb6a522c0dae9f1d9d39a8cd6f",
"gitiles_ref:refs/heads/master"
]
}
[08:21:00.336] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1615450859681856",
"id": "8853070715317092816",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d3f3dfdb1034bdfb6a522c0dae9f1d9d39a8cd6f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615450860119159",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22948",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d3f3dfdb1034bdfb6a522c0dae9f1d9d39a8cd6f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d3f3dfdb1034bdfb6a522c0dae9f1d9d39a8cd6f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018500777379824464",
"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/8853070715317092816/+/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": "1615450860119276",
"url": "https://ci.chromium.org/b/8853070715317092816",
"utcnow_ts": "1615450860313017"
}
}
[08:21:00.336] Task URL: https://ci.chromium.org/b/8853070715317092816
[08:21:00.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:2:0) after 1m0s
[08:21:03.551] Received PubSub notification, asking Buildbucket for the build status
[08:21:03.615] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:00.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:2:0)
[08:22:00.355] Timer tick, asking Buildbucket for the build status
[08:22:00.625] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:00.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:4:0) after 1m0s
[08:23:00.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:4:0)
[08:23:00.644] Timer tick, asking Buildbucket for the build status
[08:23:00.747] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:00.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:5:0) after 1m0s
[08:24:00.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:5:0)
[08:24:00.784] Timer tick, asking Buildbucket for the build status
[08:24:00.855] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:00.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:6:0) after 1m0s
[08:25:00.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:6:0)
[08:25:00.869] Timer tick, asking Buildbucket for the build status
[08:25:00.971] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:00.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:7:0) after 1m0s
[08:26:01.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:7:0)
[08:26:01.007] Timer tick, asking Buildbucket for the build status
[08:26:01.141] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:01.141] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:8:0) after 1m0s
[08:27:01.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:8:0)
[08:27:01.186] Timer tick, asking Buildbucket for the build status
[08:27:01.351] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:01.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:9:0) after 1m0s
[08:28:01.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:9:0)
[08:28:01.396] Timer tick, asking Buildbucket for the build status
[08:28:01.484] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:01.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:10:0) after 1m0s
[08:29:01.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:10:0)
[08:29:01.611] Timer tick, asking Buildbucket for the build status
[08:29:01.805] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:01.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:11:0) after 1m0s
[08:30:01.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:11:0)
[08:30:01.846] Timer tick, asking Buildbucket for the build status
[08:30:02.202] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:02.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:12:0) after 1m0s
[08:31:02.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:12:0)
[08:31:02.220] Timer tick, asking Buildbucket for the build status
[08:31:02.494] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:02.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:13:0) after 1m0s
[08:32:02.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:13:0)
[08:32:02.557] Timer tick, asking Buildbucket for the build status
[08:32:02.719] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:02.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:14:0) after 1m0s
[08:33:02.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:14:0)
[08:33:02.747] Timer tick, asking Buildbucket for the build status
[08:33:02.853] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:02.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:15:0) after 1m0s
[08:34:02.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:15:0)
[08:34:02.961] Timer tick, asking Buildbucket for the build status
[08:34:03.030] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:03.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:16:0) after 1m0s
[08:35:03.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:16:0)
[08:35:03.116] Timer tick, asking Buildbucket for the build status
[08:35:03.193] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:03.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:17:0) after 1m0s
[08:36:03.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:17:0)
[08:36:03.241] Timer tick, asking Buildbucket for the build status
[08:36:03.637] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:03.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:18:0) after 1m0s
[08:37:03.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:18:0)
[08:37:03.654] Timer tick, asking Buildbucket for the build status
[08:37:04.719] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:04.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:19:0) after 1m0s
[08:38:04.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:19:0)
[08:38:04.764] Timer tick, asking Buildbucket for the build status
[08:38:04.842] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:04.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:20:0) after 1m0s
[08:39:04.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:20:0)
[08:39:04.896] Timer tick, asking Buildbucket for the build status
[08:39:04.971] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:04.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:21:0) after 1m0s
[08:40:05.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:21:0)
[08:40:05.039] Timer tick, asking Buildbucket for the build status
[08:40:05.129] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:05.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:22:0) after 1m0s
[08:41:05.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:22:0)
[08:41:05.220] Timer tick, asking Buildbucket for the build status
[08:41:05.320] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:05.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:23:0) after 1m0s
[08:42:05.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:23:0)
[08:42:05.366] Timer tick, asking Buildbucket for the build status
[08:42:05.554] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:05.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:24:0) after 1m0s
[08:43:05.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:24:0)
[08:43:05.622] Timer tick, asking Buildbucket for the build status
[08:43:05.696] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:05.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:25:0) after 1m0s
[08:44:05.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:25:0)
[08:44:05.727] Timer tick, asking Buildbucket for the build status
[08:44:05.796] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:05.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:26:0) after 1m0s
[08:45:05.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:26:0)
[08:45:05.870] Timer tick, asking Buildbucket for the build status
[08:45:05.944] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:05.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:27:0) after 1m0s
[08:46:06.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:27:0)
[08:46:06.050] Timer tick, asking Buildbucket for the build status
[08:46:06.149] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:06.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:28:0) after 1m0s
[08:47:06.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:28:0)
[08:47:06.213] Timer tick, asking Buildbucket for the build status
[08:47:06.458] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:06.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:29:0) after 1m0s
[08:48:06.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:29:0)
[08:48:06.470] Timer tick, asking Buildbucket for the build status
[08:48:06.849] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:06.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:30:0) after 1m0s
[08:49:06.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:30:0)
[08:49:06.875] Timer tick, asking Buildbucket for the build status
[08:49:07.111] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:07.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:31:0) after 1m0s
[08:50:07.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:31:0)
[08:50:07.169] Timer tick, asking Buildbucket for the build status
[08:50:07.239] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:07.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:32:0) after 1m0s
[08:51:07.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:32:0)
[08:51:07.220] Timer tick, asking Buildbucket for the build status
[08:51:07.319] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:07.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:33:0) after 1m0s
[08:52:07.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:33:0)
[08:52:07.339] Timer tick, asking Buildbucket for the build status
[08:52:07.563] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:07.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:34:0) after 1m0s
[08:53:07.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:34:0)
[08:53:07.584] Timer tick, asking Buildbucket for the build status
[08:53:07.676] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:07.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:35:0) after 1m0s
[08:54:07.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:35:0)
[08:54:07.710] Timer tick, asking Buildbucket for the build status
[08:54:08.058] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:08.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:36:0) after 1m0s
[08:55:08.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:36:0)
[08:55:08.119] Timer tick, asking Buildbucket for the build status
[08:55:08.318] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:08.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:37:0) after 1m0s
[08:56:08.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:37:0)
[08:56:08.336] Timer tick, asking Buildbucket for the build status
[08:56:08.425] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:08.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:38:0) after 1m0s
[08:57:08.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:38:0)
[08:57:08.510] Timer tick, asking Buildbucket for the build status
[08:57:08.597] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:08.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:39:0) after 1m0s
[08:58:08.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:39:0)
[08:58:08.631] Timer tick, asking Buildbucket for the build status
[08:58:08.701] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:08.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:40:0) after 1m0s
[08:59:08.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:40:0)
[08:59:08.807] Timer tick, asking Buildbucket for the build status
[08:59:09.096] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:09.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:41:0) after 1m0s
[09:00:09.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:41:0)
[09:00:09.147] Timer tick, asking Buildbucket for the build status
[09:00:09.667] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:09.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:42:0) after 1m0s
[09:01:09.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:42:0)
[09:01:09.830] Timer tick, asking Buildbucket for the build status
[09:01:09.957] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:09.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:43:0) after 1m0s
[09:02:09.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:43:0)
[09:02:09.956] Timer tick, asking Buildbucket for the build status
[09:02:10.027] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:10.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:44:0) after 1m0s
[09:03:10.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:44:0)
[09:03:10.074] Timer tick, asking Buildbucket for the build status
[09:03:10.147] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:10.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:45:0) after 1m0s
[09:04:10.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:45:0)
[09:04:10.191] Timer tick, asking Buildbucket for the build status
[09:04:10.266] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:10.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:46:0) after 1m0s
[09:05:10.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:46:0)
[09:05:10.306] Timer tick, asking Buildbucket for the build status
[09:05:10.428] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:10.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:47:0) after 1m0s
[09:06:10.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:47:0)
[09:06:10.435] Timer tick, asking Buildbucket for the build status
[09:06:10.956] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:10.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:48:0) after 1m0s
[09:07:10.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:48:0)
[09:07:10.997] Timer tick, asking Buildbucket for the build status
[09:07:11.203] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:11.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:49:0) after 1m0s
[09:08:11.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:49:0)
[09:08:11.293] Timer tick, asking Buildbucket for the build status
[09:08:11.422] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:11.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:50:0) after 1m0s
[09:09:11.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:50:0)
[09:09:11.432] Timer tick, asking Buildbucket for the build status
[09:09:11.563] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:11.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:51:0) after 1m0s
[09:10:11.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:51:0)
[09:10:11.594] Timer tick, asking Buildbucket for the build status
[09:10:11.899] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:11.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:52:0) after 1m0s
[09:11:11.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:52:0)
[09:11:11.869] Timer tick, asking Buildbucket for the build status
[09:11:11.979] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:11.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:53:0) after 1m0s
[09:12:12.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:53:0)
[09:12:12.096] Timer tick, asking Buildbucket for the build status
[09:12:12.254] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:12.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:54:0) after 1m0s
[09:13:12.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:54:0)
[09:13:12.296] Timer tick, asking Buildbucket for the build status
[09:13:12.368] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:12.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:55:0) after 1m0s
[09:14:12.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:55:0)
[09:14:12.378] Timer tick, asking Buildbucket for the build status
[09:14:12.468] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:12.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:56:0) after 1m0s
[09:15:12.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:56:0)
[09:15:12.495] Timer tick, asking Buildbucket for the build status
[09:15:12.751] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:12.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:57:0) after 1m0s
[09:16:12.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:57:0)
[09:16:12.782] Timer tick, asking Buildbucket for the build status
[09:16:12.947] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:12.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:58:0) after 1m0s
[09:17:12.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:58:0)
[09:17:12.973] Timer tick, asking Buildbucket for the build status
[09:17:13.051] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:13.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:59:0) after 1m0s
[09:18:13.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:59:0)
[09:18:13.097] Timer tick, asking Buildbucket for the build status
[09:18:13.409] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:13.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:60:0) after 1m0s
[09:19:13.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:60:0)
[09:19:13.471] Timer tick, asking Buildbucket for the build status
[09:19:13.954] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:13.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:61:0) after 1m0s
[09:20:13.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:61:0)
[09:20:13.951] Timer tick, asking Buildbucket for the build status
[09:20:14.409] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:14.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:62:0) after 1m0s
[09:21:14.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:62:0)
[09:21:14.431] Timer tick, asking Buildbucket for the build status
[09:21:14.538] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:14.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:63:0) after 1m0s
[09:22:14.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:63:0)
[09:22:14.564] Timer tick, asking Buildbucket for the build status
[09:22:14.656] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:14.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:64:0) after 1m0s
[09:23:14.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:64:0)
[09:23:14.678] Timer tick, asking Buildbucket for the build status
[09:23:15.031] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:15.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:65:0) after 1m0s
[09:24:15.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:65:0)
[09:24:15.044] Timer tick, asking Buildbucket for the build status
[09:24:15.126] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:15.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:66:0) after 1m0s
[09:25:15.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:66:0)
[09:25:15.145] Timer tick, asking Buildbucket for the build status
[09:25:15.219] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:15.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:67:0) after 1m0s
[09:26:15.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:67:0)
[09:26:15.283] Timer tick, asking Buildbucket for the build status
[09:26:15.584] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:15.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:68:0) after 1m0s
[09:27:15.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:68:0)
[09:27:15.606] Timer tick, asking Buildbucket for the build status
[09:27:15.706] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:15.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:69:0) after 1m0s
[09:28:15.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:69:0)
[09:28:15.722] Timer tick, asking Buildbucket for the build status
[09:28:15.800] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:15.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:70:0) after 1m0s
[09:29:15.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:70:0)
[09:29:15.849] Timer tick, asking Buildbucket for the build status
[09:29:15.932] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:15.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:71:0) after 1m0s
[09:30:15.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:71:0)
[09:30:15.945] Timer tick, asking Buildbucket for the build status
[09:30:16.192] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:16.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:72:0) after 1m0s
[09:31:16.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:72:0)
[09:31:16.225] Timer tick, asking Buildbucket for the build status
[09:31:16.323] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:16.323] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:73:0) after 1m0s
[09:32:16.356] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:73:0)
[09:32:16.356] Timer tick, asking Buildbucket for the build status
[09:32:16.528] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:16.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:74:0) after 1m0s
[09:33:16.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:74:0)
[09:33:16.626] Timer tick, asking Buildbucket for the build status
[09:33:16.707] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:16.707] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:75:0) after 1m0s
[09:34:16.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:75:0)
[09:34:16.683] Timer tick, asking Buildbucket for the build status
[09:34:17.059] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:17.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:76:0) after 1m0s
[09:35:17.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:76:0)
[09:35:17.102] Timer tick, asking Buildbucket for the build status
[09:35:17.651] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:17.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:77:0) after 1m0s
[09:36:17.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:77:0)
[09:36:17.683] Timer tick, asking Buildbucket for the build status
[09:36:17.785] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:17.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:78:0) after 1m0s
[09:37:17.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:78:0)
[09:37:17.812] Timer tick, asking Buildbucket for the build status
[09:37:17.890] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:17.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:79:0) after 1m0s
[09:38:18.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:79:0)
[09:38:18.002] Timer tick, asking Buildbucket for the build status
[09:38:18.074] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:18.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:80:0) after 1m0s
[09:39:18.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:80:0)
[09:39:18.097] Timer tick, asking Buildbucket for the build status
[09:39:18.177] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:18.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:81:0) after 1m0s
[09:40:18.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:81:0)
[09:40:18.219] Timer tick, asking Buildbucket for the build status
[09:40:18.297] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:18.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:82:0) after 1m0s
[09:41:18.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:82:0)
[09:41:18.297] Timer tick, asking Buildbucket for the build status
[09:41:18.388] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:18.388] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:83:0) after 1m0s
[09:42:18.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:83:0)
[09:42:18.402] Timer tick, asking Buildbucket for the build status
[09:42:18.480] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:18.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:84:0) after 1m0s
[09:43:18.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:84:0)
[09:43:18.536] Timer tick, asking Buildbucket for the build status
[09:43:18.935] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:18.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:85:0) after 1m0s
[09:44:19.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:85:0)
[09:44:19.007] Timer tick, asking Buildbucket for the build status
[09:44:19.248] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:19.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:86:0) after 1m0s
[09:45:19.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:86:0)
[09:45:19.252] Timer tick, asking Buildbucket for the build status
[09:45:19.482] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:19.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:87:0) after 1m0s
[09:46:19.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:87:0)
[09:46:19.529] Timer tick, asking Buildbucket for the build status
[09:46:19.611] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:19.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:88:0) after 1m0s
[09:47:19.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:88:0)
[09:47:19.748] Timer tick, asking Buildbucket for the build status
[09:47:19.832] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:19.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:89:0) after 1m0s
[09:48:19.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:89:0)
[09:48:19.883] Timer tick, asking Buildbucket for the build status
[09:48:20.296] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:20.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:90:0) after 1m0s
[09:49:20.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:90:0)
[09:49:20.657] Timer tick, asking Buildbucket for the build status
[09:49:20.750] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:20.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:91:0) after 1m0s
[09:50:20.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:91:0)
[09:50:20.953] Timer tick, asking Buildbucket for the build status
[09:50:21.311] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:21.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:92:0) after 1m0s
[09:51:21.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:92:0)
[09:51:21.721] Timer tick, asking Buildbucket for the build status
[09:51:21.899] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:21.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:93:0) after 1m0s
[09:52:21.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:93:0)
[09:52:21.949] Timer tick, asking Buildbucket for the build status
[09:52:22.322] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:22.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:94:0) after 1m0s
[09:53:23.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:94:0)
[09:53:23.103] Timer tick, asking Buildbucket for the build status
[09:53:23.183] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:23.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:95:0) after 1m0s
[09:54:23.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:95:0)
[09:54:23.287] Timer tick, asking Buildbucket for the build status
[09:54:23.362] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:23.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:96:0) after 1m0s
[09:55:23.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:96:0)
[09:55:23.482] Timer tick, asking Buildbucket for the build status
[09:55:23.551] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:23.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:97:0) after 1m0s
[09:56:23.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:97:0)
[09:56:23.755] Timer tick, asking Buildbucket for the build status
[09:56:23.832] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:23.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:98:0) after 1m0s
[09:57:24.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:98:0)
[09:57:24.079] Timer tick, asking Buildbucket for the build status
[09:57:24.244] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:24.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:99:0) after 1m0s
[09:58:24.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:99:0)
[09:58:24.271] Timer tick, asking Buildbucket for the build status
[09:58:24.352] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:24.352] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:100:0) after 1m0s
[09:59:24.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:100:0)
[09:59:24.432] Timer tick, asking Buildbucket for the build status
[09:59:24.545] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:24.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:101:0) after 1m0s
[10:00:24.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:101:0)
[10:00:24.631] Timer tick, asking Buildbucket for the build status
[10:00:24.756] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:24.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:102:0) after 1m0s
[10:01:24.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:102:0)
[10:01:24.776] Timer tick, asking Buildbucket for the build status
[10:01:25.111] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:25.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:103:0) after 1m0s
[10:02:25.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:103:0)
[10:02:25.142] Timer tick, asking Buildbucket for the build status
[10:02:25.245] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:25.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:104:0) after 1m0s
[10:03:25.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:104:0)
[10:03:25.319] Timer tick, asking Buildbucket for the build status
[10:03:25.414] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:25.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:105:0) after 1m0s
[10:04:25.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:105:0)
[10:04:25.479] Timer tick, asking Buildbucket for the build status
[10:04:25.558] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:25.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:106:0) after 1m0s
[10:05:25.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:106:0)
[10:05:25.569] Timer tick, asking Buildbucket for the build status
[10:05:25.796] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:25.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:107:0) after 1m0s
[10:06:25.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:107:0)
[10:06:25.845] Timer tick, asking Buildbucket for the build status
[10:06:25.981] Build 8853070715317092816: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:25.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018500777379824464:108:0) after 1m0s
[10:06:55.521] Received PubSub notification, asking Buildbucket for the build status
[10:06:55.611] Build 8853070715317092816: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:06:55.611] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1615457214036188",
"created_by": "project:chromium",
"created_ts": "1615450859681856",
"id": "8853070715317092816",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d3f3dfdb1034bdfb6a522c0dae9f1d9d39a8cd6f\"}}",
"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\": \"d3f3dfdb1034bdfb6a522c0dae9f1d9d39a8cd6f\", \"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-44-4rk7\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22948, \"got_angle_revision\": \"44b9579cf7b8d35cac13f9e2d70c57791ddfd0e2\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"d3f3dfdb1034bdfb6a522c0dae9f1d9d39a8cd6f\", \"got_revision_cp\": \"refs/heads/master@{#861892}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a2fe8e1b2111e69d8846991f9d9bcc5c49505d1c\", \"got_v8_revision\": \"9c91874d93f2ca4e7df23a7abdb80bb888afb20b\", \"got_v8_revision_cp\": \"refs/heads/9.1.98@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"is_cached\": true, \"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\": \"d3f3dfdb1034bdfb6a522c0dae9f1d9d39a8cd6f\", \"swarm_hashes_refs/heads/master(at){#861892}_without_patch\": {\"absl_hardening_tests\": \"e156886589730eb553d794de9a2919d6300245de\", \"accessibility_unittests\": \"db4778ae673a4eda33b8299d80c8a1563cc4d720\", \"angle_unittests\": \"b6d07bd692139b0c27da3a9c58acc4e735e02594\", \"app_list_unittests\": \"8ff64dd7b9ca6ee230af8a71bb5d231912da960b\", \"app_shell_unittests\": \"42e66a13dbf7e9df640f85ada94644ca3055bda9\", \"ash_unittests\": \"800e2a05d239a97b10b8f8c82f01da09a88e96b4\", \"aura_unittests\": \"d822a4a71f0c26139ed1e7358f64e87570ab68d2\", \"base_unittests\": \"242ca05ec261768cee5446da6a0e78c80bb94c97\", \"base_util_unittests\": \"8715c7994a880258c8a1927e19c3a93c9abdc7f7\", \"blink_common_unittests\": \"1e0eadea58e34341c4edeed671f307d7a5cfa5e4\", \"blink_fuzzer_unittests\": \"b14237124224b4d84d35f8c6366b74fe6ab151fe\", \"blink_heap_unittests\": \"184987c3b576dfc281c32f5826f4e9dcfe4a79c3\", \"blink_platform_unittests\": \"da19e2a755adf19f8b2578867091d5874b175ba2\", \"blink_unittests\": \"c6496b067730c0a32df5d7a86d625e73d967964d\", \"boringssl_crypto_tests\": \"20d0261d1edca1a4545754b8372e1b027f503ab9\", \"boringssl_ssl_tests\": \"8996b0abfac947b3172eb8789b2b37f5eda7f8b9\", \"browser_tests\": \"24f3658fa3a0d7abb1b0534947ad49e7a50a9148\", \"capture_unittests\": \"a017a2c541ce204e7b52871e360b0802803259b9\", \"cast_unittests\": \"6f9f8dc7faa9320655f295b46a7f2862ef250d52\", \"cc_unittests\": \"3e0c4ac50eeae1995d4f146b73682435557542c0\", \"chrome_app_unittests\": \"f1c1cfc1d160ceb9ccc0aee742d51b167d767845\", \"chromedriver_unittests\": \"e25f4049efc34787af518cee4410842b008ad37d\", \"chromeos_components_unittests\": \"87894111a797f305d706640705348e840c387bf7\", \"chromeos_unittests\": \"b4f31cf82807af00e658d9cc278aa2d050280036\", \"color_unittests\": \"21307e92f90308affb7724dee73d2ed4ba976c34\", \"components_browsertests\": \"af833276ff2f804787801a993e8de7befbd774b9\", \"components_unittests\": \"58b4310876bc59917b438fdabd6e6bc094c2276b\", \"compositor_unittests\": \"8f424dd5b29c1ff39e277fe8ae6e343e207004e7\", \"content_browsertests\": \"dd46225cbf3817ca4de5acd01223213a1046e94b\", \"content_unittests\": \"0842b1f66d5ac1b2eaa170f90d12aa5c37dd3863\", \"crashpad_tests\": \"79d6a319aeacc28d56e6fff3dbf4e2e877d2bac4\", \"crypto_unittests\": \"1c2f5f21920ba70b9f37d65bd3db41330454661b\", \"dbus_unittests\": \"8f344f27e72ba46432df652175179feb456ddebd\", \"device_unittests\": \"9ab0fba008a047eab5b0a315dc0163f7e9a2d18a\", \"display_unittests\": \"9e05fbe1e502346cff124d1ccbf0d44a088eac05\", \"events_unittests\": \"77f3afaf2cedac0bf8192e248735106b316941b3\", \"exo_unittests\": \"7f293dc33b6e959603f2151cee73079f65efb00e\", \"extensions_browsertests\": \"0dbf59802f0285d48d161267f28611f623e259ad\", \"extensions_unittests\": \"48634b4f1a451ddde113b4c06b011ec30c69fb64\", \"filesystem_service_unittests\": \"a87e5a41d30cc5534a05289547b9720ae68ae898\", \"gcm_unit_tests\": \"a37531e49b7cf6415c1c83d25329a9f7f44afc63\", \"gfx_unittests\": \"997ceeb58ecf231cbba668673e9927fb6fb86a34\", \"gin_unittests\": \"f79aec479c1635247872e9ae793372e2ce5c99bb\", \"gl_unittests_ozone\": \"069692abe9b0721479f303ba3ce5a6086c6f6e05\", \"google_apis_unittests\": \"19edee91fafb9e8f3e65d9b5e6b5a5f8b80eda50\", \"gpu_unittests\": \"5e4e295582764e410d9934a1d20355ca4644cadf\", \"gwp_asan_unittests\": \"5563bdc595b3f08e3aee4cea1416cada4febc331\", \"interactive_ui_tests\": \"8222b9dc21f31d65b9e767407268034ff922112c\", \"ipc_tests\": \"eda04a7b8c6d8da46cd9a1aa743704853ff8ac03\", \"jingle_unittests\": \"6693ecbe4553c024b82d18b276e7090d5f325a74\", \"keyboard_unittests\": \"7ed0447467cdba756bf8d8b53268e1f5e36fd003\", \"latency_unittests\": \"191c170d30151e983c1289ad1c51b1b9a42f3e15\", \"libjingle_xmpp_unittests\": \"87925b0013e38b4524f07594ae0ec0e9c967625b\", \"liburlpattern_unittests\": \"3cfaca55a47b9914cb8505676894eb1659ccee24\", \"media_blink_unittests\": \"a7f47959e2a5278bf1fdc9bbd2579f0c34c51bad\", \"media_unittests\": \"5c493cfc0ae913fd5aa4b0dd74baf0c42c726d9e\", \"message_center_unittests\": \"ef046c9ceb850faf50cc525ac5473099179e426f\", \"midi_unittests\": \"0dfd7b57ca28ef333a76f0ca331693bf0e7f3759\", \"mojo_core_unittests\": \"c970d6a2efed635b08c7908a62bf2348a267698a\", \"mojo_unittests\": \"fb476ccf284f92bc298c12d0ea7d3a1e87f7ea16\", \"nacl_helper_nonsfi_unittests\": \"08a7d884d7e327913120ff68ff6b58dc9384ce5f\", \"nacl_loader_unittests\": \"da95ef75e654602d52db382b63c6987c23ec8f2b\", \"native_theme_unittests\": \"e14cd3085c474dd12e010f9f28c6e47c52a66126\", \"net_unittests\": \"de17e6de967dae55063342c599c4c7850b34ef5d\", \"ozone_gl_unittests\": \"1d02a29507bd30584acc5d1751b8a07de4df1152\", \"ozone_unittests\": \"0f57c766939e287c04cfec2eb50ea784cd5d9d7a\", \"ozone_x11_unittests\": \"596c50daad1f28446099448ef1c3d0b73fdbd409\", \"pdf_unittests\": \"8699f88006da55424da25b67c09d900d39a94737\", \"perfetto_unittests\": \"9f50abd9f6e390bf527c62784fd1053b6f61f377\", \"ppapi_unittests\": \"8fae77181339dde41d2f2253b6d7175031bde721\", \"printing_unittests\": \"128d8cb69dd83786ef04f4e190bfbcd9b1f9dbe3\", \"remoting_unittests\": \"87f321ddfedec6d19009217df32b4084aae368da\", \"sandbox_linux_unittests\": \"06422240e62bef1d775b1600a9c058c46d76c755\", \"service_manager_unittests\": \"639c43fc8ace9f2ea21081f35d309f8a7cab32e2\", \"services_unittests\": \"c6bf8cee9ce093fc47480e1e26003d628825217a\", \"shell_dialogs_unittests\": \"29d43af5b5c4d40687fbfcc382f93b351fd26fc1\", \"shell_encryption_unittests\": \"55d79d177cbf8b05d27db73fbeca44b7e218a797\", \"skia_unittests\": \"c55183e8cc49f63de2508217d620592277bf03c8\", \"snapshot_unittests\": \"22ed14bccb792b129d5b5d10ffb4c06503a040ee\", \"sql_unittests\": \"c642dcd745da7e263e39f075f5f484b75d9933a5\", \"storage_unittests\": \"8b7fba40c259a1c6ffdd61206405ad8f07bfd149\", \"sync_integration_tests\": \"f92f75d9a2a6deb74cdb162de81f4f00f9d748f1\", \"traffic_annotation_auditor_unittests\": \"fb677de9572b39020e686d88394a714dad76ec31\", \"ui_base_unittests\": \"6bf462377e3bbb2eeb9dadc48e6ab80d68e58af2\", \"ui_chromeos_unittests\": \"6b9777fa408089439acc3d2485c9970ccc21ccfb\", \"ui_touch_selection_unittests\": \"ab8442ea39bd2bcbba46680298a9514797cf2e02\", \"unit_tests\": \"d933a71147e5d986c988923b6eb8250061ea34ca\", \"url_unittests\": \"e62528ce5caaa2c06f4fbf7878e8edc9741a60be\", \"usage_time_limit_unittests\": \"da39f3180c3d5e1f72e317dec291276b925e3d9d\", \"views_unittests\": \"2947215e1c5de736cb5566f9fc72944d84e4e48d\", \"viz_unittests\": \"a7ca6e05f693a55ada42af70d84dc7972606d47c\", \"wayland_client_tests\": \"a82e51e3049d0635e74bb4761703e849ddb83edc\", \"wm_unittests\": \"3ebd9b43fa89da909ba5f6168134ee757729107e\", \"wtf_unittests\": \"ed3bbb0fac776c63aa2e8736ad779e5c582a1a41\", \"zlib_unittests\": \"a1c6df755971f579d5885cba33dbf6e635c505c1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_6c78a7f8d33b40824ce59948f4a03b9b1d7e446f2adcc16b16c0c54004d8c305_v2\", \"builder_8083860191ac1707bdac6310382d6ca226876fc8f88202f45d8d07453f74f5a4_v2\", \"builder_9ab1612fdb00db29a8d60b17a842600a8e29ecb37944be685dafbc3ddd01329a_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_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-44-4rk7\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615450862901428",
"status": "COMPLETED",
"status_changed_ts": "1615457214532724",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22948",
"builder:linux-chromeos-dbg",
"buildset:commit/git/d3f3dfdb1034bdfb6a522c0dae9f1d9d39a8cd6f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d3f3dfdb1034bdfb6a522c0dae9f1d9d39a8cd6f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018500777379824464",
"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/8853070715317092816/+/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:52393173232f3010",
"user_agent:luci-scheduler"
],
"updated_ts": "1615457214544731",
"url": "https://ci.chromium.org/b/8853070715317092816",
"utcnow_ts": "1615457215603601"
}
}
[10:06:55.611] Invocation finished in 1h45m57.280271215s with status SUCCEEDED