[13:29:18.783] New invocation is queued and will start shortly
[13:29:19.958] Starting the invocation (attempt 1)
[13:29:20.010] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:29:20.010] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:29:20.010] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030349580894994352",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9de4a54c47ff32ca656afd78114a5a393fc74dad\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9030349580894994352",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/9de4a54c47ff32ca656afd78114a5a393fc74dad",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9de4a54c47ff32ca656afd78114a5a393fc74dad",
"gitiles_ref:refs/heads/master"
]
}
[13:29:21.004] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1604150960216091",
"id": "8864919518698914976",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9de4a54c47ff32ca656afd78114a5a393fc74dad\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604150960841766",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42448",
"builder:linux-chromeos-rel",
"buildset:commit/git/9de4a54c47ff32ca656afd78114a5a393fc74dad",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9de4a54c47ff32ca656afd78114a5a393fc74dad",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030349580894994352",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8864919518698914976/+/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": "1604150960841908",
"url": "https://ci.chromium.org/b/8864919518698914976",
"utcnow_ts": "1604150960992728"
}
}
[13:29:21.004] Task URL: https://ci.chromium.org/b/8864919518698914976
[13:29:21.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:2:0) after 1m0s
[13:30:21.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:2:0)
[13:30:21.029] Timer tick, asking Buildbucket for the build status
[13:30:21.130] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:30:21.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:3:0) after 1m0s
[13:31:21.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:3:0)
[13:31:21.152] Timer tick, asking Buildbucket for the build status
[13:31:21.243] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:31:21.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:4:0) after 1m0s
[13:32:21.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:4:0)
[13:32:21.231] Timer tick, asking Buildbucket for the build status
[13:32:21.505] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:32:21.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:5:0) after 1m0s
[13:33:21.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:5:0)
[13:33:21.533] Timer tick, asking Buildbucket for the build status
[13:33:21.790] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:33:21.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:6:0) after 1m0s
[13:34:21.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:6:0)
[13:34:21.870] Timer tick, asking Buildbucket for the build status
[13:34:21.947] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:34:21.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:7:0) after 1m0s
[13:35:21.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:7:0)
[13:35:21.966] Timer tick, asking Buildbucket for the build status
[13:35:22.115] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:35:22.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:8:0) after 1m0s
[13:36:22.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:8:0)
[13:36:22.135] Timer tick, asking Buildbucket for the build status
[13:36:22.224] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:36:22.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:9:0) after 1m0s
[13:37:22.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:9:0)
[13:37:22.255] Timer tick, asking Buildbucket for the build status
[13:37:22.348] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:37:22.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:10:0) after 1m0s
[13:38:22.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:10:0)
[13:38:22.379] Timer tick, asking Buildbucket for the build status
[13:38:22.488] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:38:22.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:11:0) after 1m0s
[13:39:22.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:11:0)
[13:39:22.517] Timer tick, asking Buildbucket for the build status
[13:39:22.769] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:39:22.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:12:0) after 1m0s
[13:40:22.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:12:0)
[13:40:22.790] Timer tick, asking Buildbucket for the build status
[13:40:22.857] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:40:22.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:13:0) after 1m0s
[13:41:22.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:13:0)
[13:41:22.982] Timer tick, asking Buildbucket for the build status
[13:41:23.095] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:41:23.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:14:0) after 1m0s
[13:42:23.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:14:0)
[13:42:23.118] Timer tick, asking Buildbucket for the build status
[13:42:23.205] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:42:23.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:15:0) after 1m0s
[13:43:23.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:15:0)
[13:43:23.237] Timer tick, asking Buildbucket for the build status
[13:43:23.333] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:43:23.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:16:0) after 1m0s
[13:44:23.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:16:0)
[13:44:23.353] Timer tick, asking Buildbucket for the build status
[13:44:23.453] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:44:23.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:17:0) after 1m0s
[13:45:23.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:17:0)
[13:45:23.487] Timer tick, asking Buildbucket for the build status
[13:45:23.573] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:45:23.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:18:0) after 1m0s
[13:46:23.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:18:0)
[13:46:23.621] Timer tick, asking Buildbucket for the build status
[13:46:23.881] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:46:23.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:19:0) after 1m0s
[13:47:23.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:19:0)
[13:47:23.944] Timer tick, asking Buildbucket for the build status
[13:47:24.171] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:47:24.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:20:0) after 1m0s
[13:48:24.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:20:0)
[13:48:24.194] Timer tick, asking Buildbucket for the build status
[13:48:24.312] Build 8864919518698914976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:48:24.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:21:0) after 1m0s
[13:48:55.288] Received PubSub notification, asking Buildbucket for the build status
[13:48:55.385] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:24.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:21:0)
[13:49:24.337] Timer tick, asking Buildbucket for the build status
[13:49:24.814] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:24.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:23:0) after 1m0s
[13:50:24.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:23:0)
[13:50:24.935] Timer tick, asking Buildbucket for the build status
[13:50:25.304] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:25.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:24:0) after 1m0s
[13:51:25.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:24:0)
[13:51:25.381] Timer tick, asking Buildbucket for the build status
[13:51:25.449] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:25.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:25:0) after 1m0s
[13:52:25.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:25:0)
[13:52:25.477] Timer tick, asking Buildbucket for the build status
[13:52:25.741] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:25.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:26:0) after 1m0s
[13:53:25.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:26:0)
[13:53:25.784] Timer tick, asking Buildbucket for the build status
[13:53:25.848] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:25.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:27:0) after 1m0s
[13:54:25.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:27:0)
[13:54:25.924] Timer tick, asking Buildbucket for the build status
[13:54:26.353] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:26.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:28:0) after 1m0s
[13:55:26.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:28:0)
[13:55:26.351] Timer tick, asking Buildbucket for the build status
[13:55:26.453] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:26.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:29:0) after 1m0s
[13:56:26.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:29:0)
[13:56:26.481] Timer tick, asking Buildbucket for the build status
[13:56:26.556] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:26.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:30:0) after 1m0s
[13:57:26.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:30:0)
[13:57:26.580] Timer tick, asking Buildbucket for the build status
[13:57:26.690] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:26.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:31:0) after 1m0s
[13:58:26.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:31:0)
[13:58:26.756] Timer tick, asking Buildbucket for the build status
[13:58:26.846] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:26.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:32:0) after 1m0s
[13:59:26.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:32:0)
[13:59:26.897] Timer tick, asking Buildbucket for the build status
[13:59:27.023] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:27.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:33:0) after 1m0s
[14:00:27.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:33:0)
[14:00:27.051] Timer tick, asking Buildbucket for the build status
[14:00:27.379] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:27.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:34:0) after 1m0s
[14:01:27.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:34:0)
[14:01:27.427] Timer tick, asking Buildbucket for the build status
[14:01:27.732] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:27.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:35:0) after 1m0s
[14:02:27.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:35:0)
[14:02:27.834] Timer tick, asking Buildbucket for the build status
[14:02:28.014] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:28.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:36:0) after 1m0s
[14:03:28.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:36:0)
[14:03:28.054] Timer tick, asking Buildbucket for the build status
[14:03:28.128] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:28.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:37:0) after 1m0s
[14:04:28.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:37:0)
[14:04:28.222] Timer tick, asking Buildbucket for the build status
[14:04:28.328] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:28.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:38:0) after 1m0s
[14:05:28.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:38:0)
[14:05:28.351] Timer tick, asking Buildbucket for the build status
[14:05:28.412] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:28.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:39:0) after 1m0s
[14:06:28.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:39:0)
[14:06:28.434] Timer tick, asking Buildbucket for the build status
[14:06:28.495] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:28.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:40:0) after 1m0s
[14:07:28.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:40:0)
[14:07:28.519] Timer tick, asking Buildbucket for the build status
[14:07:28.581] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:28.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:41:0) after 1m0s
[14:08:28.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:41:0)
[14:08:28.643] Timer tick, asking Buildbucket for the build status
[14:08:28.739] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:28.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:42:0) after 1m0s
[14:09:28.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:42:0)
[14:09:28.813] Timer tick, asking Buildbucket for the build status
[14:09:28.925] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:28.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:43:0) after 1m0s
[14:10:28.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:43:0)
[14:10:28.959] Timer tick, asking Buildbucket for the build status
[14:10:29.070] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:29.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:44:0) after 1m0s
[14:11:29.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:44:0)
[14:11:29.109] Timer tick, asking Buildbucket for the build status
[14:11:29.195] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:29.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:45:0) after 1m0s
[14:12:29.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:45:0)
[14:12:29.236] Timer tick, asking Buildbucket for the build status
[14:12:29.302] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:29.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:46:0) after 1m0s
[14:13:29.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:46:0)
[14:13:29.334] Timer tick, asking Buildbucket for the build status
[14:13:29.410] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:29.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:47:0) after 1m0s
[14:14:29.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:47:0)
[14:14:29.444] Timer tick, asking Buildbucket for the build status
[14:14:29.570] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:29.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:48:0) after 1m0s
[14:15:29.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:48:0)
[14:15:29.583] Timer tick, asking Buildbucket for the build status
[14:15:29.768] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:29.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:49:0) after 1m0s
[14:16:29.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:49:0)
[14:16:29.763] Timer tick, asking Buildbucket for the build status
[14:16:30.027] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:30.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:50:0) after 1m0s
[14:17:30.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:50:0)
[14:17:30.062] Timer tick, asking Buildbucket for the build status
[14:17:30.144] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:30.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:51:0) after 1m0s
[14:18:30.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:51:0)
[14:18:30.238] Timer tick, asking Buildbucket for the build status
[14:18:30.367] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:30.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:52:0) after 1m0s
[14:19:30.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:52:0)
[14:19:30.452] Timer tick, asking Buildbucket for the build status
[14:19:30.602] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:30.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:53:0) after 1m0s
[14:20:30.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:53:0)
[14:20:30.625] Timer tick, asking Buildbucket for the build status
[14:20:30.806] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:30.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:54:0) after 1m0s
[14:21:30.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:54:0)
[14:21:30.831] Timer tick, asking Buildbucket for the build status
[14:21:30.912] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:30.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:55:0) after 1m0s
[14:22:30.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:55:0)
[14:22:30.941] Timer tick, asking Buildbucket for the build status
[14:22:31.021] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:31.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:56:0) after 1m0s
[14:23:31.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:56:0)
[14:23:31.084] Timer tick, asking Buildbucket for the build status
[14:23:31.209] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:31.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:57:0) after 1m0s
[14:24:31.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:57:0)
[14:24:31.242] Timer tick, asking Buildbucket for the build status
[14:24:31.562] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:31.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:58:0) after 1m0s
[14:25:31.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:58:0)
[14:25:31.608] Timer tick, asking Buildbucket for the build status
[14:25:31.680] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:31.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:59:0) after 1m0s
[14:26:31.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:59:0)
[14:26:31.798] Timer tick, asking Buildbucket for the build status
[14:26:31.868] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:31.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:60:0) after 1m0s
[14:27:32.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:60:0)
[14:27:32.028] Timer tick, asking Buildbucket for the build status
[14:27:32.114] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:32.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:61:0) after 1m0s
[14:28:32.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:61:0)
[14:28:32.275] Timer tick, asking Buildbucket for the build status
[14:28:32.330] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:32.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:62:0) after 1m0s
[14:29:32.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:62:0)
[14:29:32.373] Timer tick, asking Buildbucket for the build status
[14:29:32.679] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:32.679] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:63:0) after 1m0s
[14:30:32.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:63:0)
[14:30:32.718] Timer tick, asking Buildbucket for the build status
[14:30:32.827] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:32.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:64:0) after 1m0s
[14:31:32.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:64:0)
[14:31:32.929] Timer tick, asking Buildbucket for the build status
[14:31:33.033] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:33.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:65:0) after 1m0s
[14:32:33.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:65:0)
[14:32:33.132] Timer tick, asking Buildbucket for the build status
[14:32:33.189] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:33.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:66:0) after 1m0s
[14:33:33.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:66:0)
[14:33:33.350] Timer tick, asking Buildbucket for the build status
[14:33:33.513] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:33.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:67:0) after 1m0s
[14:34:33.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:67:0)
[14:34:33.555] Timer tick, asking Buildbucket for the build status
[14:34:33.742] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:33.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:68:0) after 1m0s
[14:35:33.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:68:0)
[14:35:33.769] Timer tick, asking Buildbucket for the build status
[14:35:33.846] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:33.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:69:0) after 1m0s
[14:36:33.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:69:0)
[14:36:33.877] Timer tick, asking Buildbucket for the build status
[14:36:34.182] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:34.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:70:0) after 1m0s
[14:37:34.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:70:0)
[14:37:34.275] Timer tick, asking Buildbucket for the build status
[14:37:34.544] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:34.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:71:0) after 1m0s
[14:38:34.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:71:0)
[14:38:34.544] Timer tick, asking Buildbucket for the build status
[14:38:34.616] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:34.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:72:0) after 1m0s
[14:39:34.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:72:0)
[14:39:34.707] Timer tick, asking Buildbucket for the build status
[14:39:34.831] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:34.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:73:0) after 1m0s
[14:40:34.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:73:0)
[14:40:34.875] Timer tick, asking Buildbucket for the build status
[14:40:34.989] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:34.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:74:0) after 1m0s
[14:41:35.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:74:0)
[14:41:35.098] Timer tick, asking Buildbucket for the build status
[14:41:35.216] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:35.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:75:0) after 1m0s
[14:42:35.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:75:0)
[14:42:35.237] Timer tick, asking Buildbucket for the build status
[14:42:35.332] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:35.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:76:0) after 1m0s
[14:43:35.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:76:0)
[14:43:35.417] Timer tick, asking Buildbucket for the build status
[14:43:35.487] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:35.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:77:0) after 1m0s
[14:44:35.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:77:0)
[14:44:35.601] Timer tick, asking Buildbucket for the build status
[14:44:35.692] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:35.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:78:0) after 1m0s
[14:45:35.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:78:0)
[14:45:35.796] Timer tick, asking Buildbucket for the build status
[14:45:35.861] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:35.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:79:0) after 1m0s
[14:46:35.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:79:0)
[14:46:35.978] Timer tick, asking Buildbucket for the build status
[14:46:36.058] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:36.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:80:0) after 1m0s
[14:47:36.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:80:0)
[14:47:36.103] Timer tick, asking Buildbucket for the build status
[14:47:36.165] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:36.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:81:0) after 1m0s
[14:48:36.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:81:0)
[14:48:36.280] Timer tick, asking Buildbucket for the build status
[14:48:36.369] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:36.369] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:82:0) after 1m0s
[14:49:36.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:82:0)
[14:49:36.448] Timer tick, asking Buildbucket for the build status
[14:49:36.595] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:36.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:83:0) after 1m0s
[14:50:36.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:83:0)
[14:50:36.644] Timer tick, asking Buildbucket for the build status
[14:50:36.719] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:36.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:84:0) after 1m0s
[14:51:36.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:84:0)
[14:51:36.776] Timer tick, asking Buildbucket for the build status
[14:51:36.850] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:36.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:85:0) after 1m0s
[14:52:36.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:85:0)
[14:52:36.841] Timer tick, asking Buildbucket for the build status
[14:52:36.953] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:36.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:86:0) after 1m0s
[14:53:37.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:86:0)
[14:53:37.000] Timer tick, asking Buildbucket for the build status
[14:53:37.283] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:37.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:87:0) after 1m0s
[14:54:37.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:87:0)
[14:54:37.358] Timer tick, asking Buildbucket for the build status
[14:54:37.544] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:37.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:88:0) after 1m0s
[14:55:37.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:88:0)
[14:55:37.576] Timer tick, asking Buildbucket for the build status
[14:55:37.745] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:37.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:89:0) after 1m0s
[14:56:37.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:89:0)
[14:56:37.783] Timer tick, asking Buildbucket for the build status
[14:56:37.901] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:37.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:90:0) after 1m0s
[14:57:37.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:90:0)
[14:57:37.924] Timer tick, asking Buildbucket for the build status
[14:57:38.049] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:38.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:91:0) after 1m0s
[14:58:38.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:91:0)
[14:58:38.105] Timer tick, asking Buildbucket for the build status
[14:58:38.198] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:38.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:92:0) after 1m0s
[14:59:38.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:92:0)
[14:59:38.239] Timer tick, asking Buildbucket for the build status
[14:59:38.394] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:38.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:93:0) after 1m0s
[15:00:38.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:93:0)
[15:00:38.591] Timer tick, asking Buildbucket for the build status
[15:00:38.751] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:38.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:94:0) after 1m0s
[15:01:38.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:94:0)
[15:01:38.813] Timer tick, asking Buildbucket for the build status
[15:01:39.003] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:39.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:95:0) after 1m0s
[15:02:39.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:95:0)
[15:02:39.033] Timer tick, asking Buildbucket for the build status
[15:02:40.432] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:40.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:96:0) after 1m0s
[15:03:40.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:96:0)
[15:03:40.473] Timer tick, asking Buildbucket for the build status
[15:03:40.846] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:40.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:97:0) after 1m0s
[15:04:40.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:97:0)
[15:04:40.901] Timer tick, asking Buildbucket for the build status
[15:04:41.031] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:41.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:98:0) after 1m0s
[15:05:41.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:98:0)
[15:05:41.123] Timer tick, asking Buildbucket for the build status
[15:05:41.371] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:41.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:99:0) after 1m0s
[15:06:41.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:99:0)
[15:06:41.453] Timer tick, asking Buildbucket for the build status
[15:06:41.645] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:41.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:100:0) after 1m0s
[15:07:41.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:100:0)
[15:07:41.679] Timer tick, asking Buildbucket for the build status
[15:07:41.843] Build 8864919518698914976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:41.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030349580894994352:101:0) after 1m0s
[15:07:55.543] Received PubSub notification, asking Buildbucket for the build status
[15:07:55.652] Build 8864919518698914976: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:07:55.652] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1604156873703143",
"created_by": "project:chromium",
"created_ts": "1604150960216091",
"id": "8864919518698914976",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9de4a54c47ff32ca656afd78114a5a393fc74dad\"}}",
"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\": \"9de4a54c47ff32ca656afd78114a5a393fc74dad\", \"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-41-dr51\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42448, \"got_angle_revision\": \"42ad027982404039e6c9a921b2f6354f55b65a2e\", \"got_dawn_revision\": \"0a374dce665328391ab3b68fd9e667b018dd9dcd\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"9de4a54c47ff32ca656afd78114a5a393fc74dad\", \"got_revision_cp\": \"refs/heads/master@{#822962}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e0de282e678b72dac25b81f8d25305231aec01f8\", \"got_v8_revision\": \"69c856dc816ff1dd65fcc536095b44399a7434b9\", \"got_v8_revision_cp\": \"refs/heads/8.8.214@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9de4a54c47ff32ca656afd78114a5a393fc74dad\", \"swarm_hashes_refs/heads/master(at){#822962}_without_patch\": {\"absl_hardening_tests\": \"94032ad96ee841b5ba3448b799c19b55cdd409f6\", \"accessibility_unittests\": \"8ceb51b2ab165e5d5fe807b3f2db5226431868b6\", \"angle_unittests\": \"f4fe989cacd3aa3e33d34a61b77d3e5efd3682cd\", \"app_list_unittests\": \"9131426d996f0d7c61cc23fb2810cc0ae91cd7c7\", \"app_shell_unittests\": \"8a1237a8837510fe74a538b51a81418916e7a851\", \"ash_unittests\": \"b82a7a6e867ee84604838711ec59c3c3d60eb6c2\", \"aura_unittests\": \"413c6192e249f5e7ea091ed26a0ddaac4716f505\", \"base_unittests\": \"3d38bd54db34f89fd5cc35608c84f4dcba9d226a\", \"base_util_unittests\": \"3d05ef2082b2ae682a0caf9d51c391f8b3ab79d3\", \"blink_common_unittests\": \"ceeb02cd2d83b5c5363adca4c1aafd5a9a18a493\", \"blink_fuzzer_unittests\": \"aec8c7461c0e933ce5083c718fb9972e59cd4281\", \"blink_heap_unittests\": \"7b9490611c1bc4d78fdeeb542f8ad935102c4297\", \"blink_platform_unittests\": \"e96193912e0e5b99b2a0fc46a629674d3bedc424\", \"blink_unittests\": \"e94bfa8ed7f5386a5b541ba9c4a156c2cb129bc8\", \"boringssl_crypto_tests\": \"f56b7a4f29864c8b63ff6161ea8c1064bd0570af\", \"boringssl_ssl_tests\": \"41ab5a350ca270f1b14fd6c342289c25a8007d8b\", \"browser_tests\": \"1565202b4a3d80615bcf6658b7faf613ceb4e730\", \"capture_unittests\": \"febfc48466120aa55efee4914fc3d6291890461f\", \"cast_unittests\": \"fd59059ef7dcceab91c6c39fbf183d575857ffbd\", \"cc_unittests\": \"c22facf6011961c13c6eb3ce7dbc290932b81d1a\", \"chrome_app_unittests\": \"7f54afc6c1ad9903f77453a43f327e25be9a6d33\", \"chromedriver_unittests\": \"0099c5da2ebed0299dac3fef2c1aca35d7fda7a0\", \"chromeos_components_unittests\": \"ee0099f9ef2d8e8c6c0a3700ee28f7b2b39fea92\", \"chromeos_unittests\": \"eaf1e897b0e281840ab17ef33ee8e4ae79649e54\", \"components_browsertests\": \"2e4f06175d9e3bbc18592c06494c4716e2384692\", \"components_unittests\": \"97bf4669f66970ffaa96c5da48511ff90accfa4a\", \"compositor_unittests\": \"6079fb19e5fcc42b44d3d86c5f3209ee101f6c99\", \"content_browsertests\": \"01717342e05ef5094eacb13ed5b74ab237b84a64\", \"content_unittests\": \"1095111067b030e105c3a20fd59e0189f7e14269\", \"crypto_unittests\": \"a275f2c1734cf538f979a68c592b5f6e7b06d617\", \"dbus_unittests\": \"215452eb62df0f8253536f6bddd5e58f28cbf32d\", \"device_unittests\": \"136112754da0b6c47dac2869cc96e62742e82bca\", \"display_unittests\": \"e1f0a59ae75cd06d58a5f4cafeb5e254f558bb4d\", \"events_unittests\": \"b467a0b7327f9ae172f868059d3a6b28c9d06a23\", \"exo_unittests\": \"d1aa63d9e631c2e19fea859f169901685a025976\", \"extensions_browsertests\": \"695e6eb67c112b42b4b197c3299e95462ce39a96\", \"extensions_unittests\": \"02fc2cf41a9db133e1ef750846d272254c5fa00a\", \"filesystem_service_unittests\": \"9820fe3b986e3a8ee13220b63260b0b6595c101b\", \"gcm_unit_tests\": \"830cac56f56d2a0a5aa55b4ff12508073a0f62a7\", \"gfx_unittests\": \"515d1089336a4f007dadd69acbbdb2a2fa0e21bf\", \"gin_unittests\": \"463c241aeec583aab7bb2746d79d4a8697439c8a\", \"gl_unittests_ozone\": \"6a5ec537e27b15ef6bcab14a4955ff234c6fc050\", \"google_apis_unittests\": \"cfa3606948df700ac8f8f29794c1400a1f1170f5\", \"gpu_unittests\": \"0e44c3f1a1a6b7265ec77e6afbff4b8d5824c64f\", \"gwp_asan_unittests\": \"0f711f2ace61882bc76efacccb22b62df9cd152e\", \"interactive_ui_tests\": \"04608220b4b97aabafae89a3b636d65a04d46bdb\", \"ipc_tests\": \"0f27303bb8f9d7d6fe3196235447f5364ba3b3b7\", \"jingle_unittests\": \"d0605566983d73749cc1323e15c2051c2d308578\", \"keyboard_unittests\": \"cbb4a6940cd5b5149ceba182b8faeb82f99d14a4\", \"latency_unittests\": \"f9c710d2345088a8ef48c5f01f6a33567194f406\", \"libjingle_xmpp_unittests\": \"626119dfb905ed0644806731e597987cafeee881\", \"liburlpattern_unittests\": \"e8740c4d986c7c335646e76578663bb54e9059dc\", \"media_blink_unittests\": \"2ecc5e29ec58f69b50dd482c6f3b51b2f1a2ae14\", \"media_unittests\": \"c7b09c67e9cab727646ff54684ca3408715468d2\", \"message_center_unittests\": \"8b4313bb4d65da29252ec7e062536d4e19f3bbd9\", \"midi_unittests\": \"7d69d7abc3f04654664f73f1f0d4c39baee7ecd1\", \"mojo_core_unittests\": \"8b1ed06f79ab8fbe7c61515d69560450b5f14f33\", \"mojo_unittests\": \"a9192878b1d0914095c6422d909dd6da3b0a03d5\", \"nacl_helper_nonsfi_unittests\": \"8767c0a462922d842e7b987978467f21c6cbd1af\", \"nacl_loader_unittests\": \"1fd94caa8aa5a5439e67f155cfb18a3338294d8a\", \"native_theme_unittests\": \"4d8eb37dfcc1a680366cc0f630fe4526ba9f2b81\", \"net_unittests\": \"78227fdf0cc6d28e2bde75865a7f432ae239b2fb\", \"ozone_gl_unittests\": \"ee9f380dbfce6d315f9bac8728d18e5ac2b9117c\", \"ozone_unittests\": \"545304b9e1307d9293ff9a40600381c69bf47f85\", \"ozone_x11_unittests\": \"8722bea8a3aa226ed9f74b60a2bebb7356470a20\", \"pdf_unittests\": \"a56830352a77ccb3005827339ebec250cb87d096\", \"perfetto_unittests\": \"dae1418a11f940c08aac8e760ed0d9f696953bf2\", \"ppapi_unittests\": \"83eae650147a1288b062b94f26155fde2a967cbf\", \"printing_unittests\": \"8825e52292025ce6fe79b441a535d908e533a3c4\", \"remoting_unittests\": \"93d6eced77c08635246e9936f23a1837196b198a\", \"sandbox_linux_unittests\": \"2be99528eefbf2dcdc33bfe2ffc47ae8f5eff613\", \"service_manager_unittests\": \"3af87d06139c2a8512310d3472e135d75139accc\", \"services_unittests\": \"769c9f7c0605afa821637b5c79129e6a544b56a7\", \"shell_dialogs_unittests\": \"86347af6628d35653cc6dbe614ccd843cd7c4bb1\", \"skia_unittests\": \"9d30ada01f74fce5aca2fcd1fda605bab994d215\", \"snapshot_unittests\": \"b5639e909e1fb5b07f8a0f4ca363d669aeb44871\", \"sql_unittests\": \"354a0db61f1c74628a5433bc0a533843eb480ac1\", \"storage_unittests\": \"da76728b80eecb63eaefd2bfc801ea2587e43a0a\", \"sync_integration_tests\": \"461e754d1a05596bf45fea052ca4dd26b2205040\", \"traffic_annotation_auditor_unittests\": \"3732b0bcae98f29408abf1a4a9fa2a201f66b949\", \"ui_base_unittests\": \"d3cf6aeab93aa451dce5cc2b3faee91cb795f5ab\", \"ui_chromeos_unittests\": \"9fd7d3819829970886db4b2f9f36a9d4de720197\", \"ui_touch_selection_unittests\": \"43937ecdd58c3dbb46255141d6f8d5007852d841\", \"unit_tests\": \"645407ae43c4f73aa8f5ed787c2cc2974f3f412b\", \"url_unittests\": \"6b8f8b1a88e8f79d4ecef89fd6ba9d8df6a54676\", \"usage_time_limit_unittests\": \"30ed55546fae66f800ca969eda807b6d068c1d6d\", \"views_unittests\": \"e332c9968b896f6d0933e0953e976e5c02a13b9e\", \"viz_unittests\": \"fb6c110993efdd97f131dd0699106206a1b5d575\", \"wayland_client_perftests\": \"57408c87757925ee78148fd619e8ebae366020e7\", \"wm_unittests\": \"f49f8459ec9a3972a8eb972cd4adde8644f0b72f\", \"wtf_unittests\": \"ad9d0e5e9d8ae36f8998d4769261aed8ffa8d53b\", \"zlib_unittests\": \"f8a7f0f9b2e3ffd3365605523bb2d42bce5c97e5\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_430de131691c92065dcde51cfe816220b2f886d2d859c4fe33bcc0b34c123c61_v2\", \"builder_8e7ad9a10a7772feba5b42dda56992e918fe88f23579c3ddaf696dde66ee4238_v2\", \"builder_b452dbd0948c9cc8e5da17ae2667b73a702b3c833f9453e00f98c9bad535ddc3_v2\", \"builder_f5174a4d80cdc4c8aa1989fa45d69979d28910f768af140dd646791c34143bfe_v2\", \"builder_f72b88ee7914fe5eb8b32d979ad6b47003d3a0322a10970d43d78c86a32dd14e_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-41-dr51\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604152134606744",
"status": "COMPLETED",
"status_changed_ts": "1604156874211530",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42448",
"builder:linux-chromeos-rel",
"buildset:commit/git/9de4a54c47ff32ca656afd78114a5a393fc74dad",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9de4a54c47ff32ca656afd78114a5a393fc74dad",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030349580894994352",
"scheduler_job_id:chromium/linux-chromeos-rel",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8864919518698914976/+/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:4f97aaacd664e610",
"user_agent:luci-scheduler"
],
"updated_ts": "1604156874273912",
"url": "https://ci.chromium.org/b/8864919518698914976",
"utcnow_ts": "1604156875635584"
}
}
[15:07:55.652] Invocation finished in 1h38m36.913891016s with status SUCCEEDED