[23:12:48.886] New invocation is queued and will start shortly
[23:12:50.002] Starting the invocation (attempt 1)
[23:12:50.047] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:12:50.047] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:12:50.047] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027594961140922688",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"11be620585749c6d1e1b2fac4d5bb39550d3dd58\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9027594961140922688",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/11be620585749c6d1e1b2fac4d5bb39550d3dd58",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11be620585749c6d1e1b2fac4d5bb39550d3dd58",
"gitiles_ref:refs/heads/master"
]
}
[23:12:50.975] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1606777970179012",
"id": "8862164899099940768",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11be620585749c6d1e1b2fac4d5bb39550d3dd58\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1606777970788243",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43319",
"builder:linux-chromeos-rel",
"buildset:commit/git/11be620585749c6d1e1b2fac4d5bb39550d3dd58",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11be620585749c6d1e1b2fac4d5bb39550d3dd58",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027594961140922688",
"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/8862164899099940768/+/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": "1606777970788455",
"url": "https://ci.chromium.org/b/8862164899099940768",
"utcnow_ts": "1606777970966636"
}
}
[23:12:50.975] Task URL: https://ci.chromium.org/b/8862164899099940768
[23:12:50.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:2:0) after 1m0s
[23:13:50.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:2:0)
[23:13:50.999] Timer tick, asking Buildbucket for the build status
[23:13:52.392] Build 8862164899099940768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:13:52.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:3:0) after 1m0s
[23:14:52.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:3:0)
[23:14:52.626] Timer tick, asking Buildbucket for the build status
[23:14:52.711] Build 8862164899099940768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:14:52.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:4:0) after 1m0s
[23:15:52.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:4:0)
[23:15:52.772] Timer tick, asking Buildbucket for the build status
[23:15:52.847] Build 8862164899099940768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:15:52.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:5:0) after 1m0s
[23:16:52.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:5:0)
[23:16:52.868] Timer tick, asking Buildbucket for the build status
[23:16:53.008] Build 8862164899099940768: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:16:53.008] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:6:0) after 1m0s
[23:17:06.154] Received PubSub notification, asking Buildbucket for the build status
[23:17:06.420] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:53.100] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:6:0)
[23:17:53.100] Timer tick, asking Buildbucket for the build status
[23:17:53.655] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:53.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:8:0) after 1m0s
[23:18:53.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:8:0)
[23:18:53.733] Timer tick, asking Buildbucket for the build status
[23:18:53.888] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:53.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:9:0) after 1m0s
[23:19:53.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:9:0)
[23:19:53.953] Timer tick, asking Buildbucket for the build status
[23:19:54.040] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:54.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:10:0) after 1m0s
[23:20:54.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:10:0)
[23:20:54.088] Timer tick, asking Buildbucket for the build status
[23:20:54.980] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:54.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:11:0) after 1m0s
[23:21:55.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:11:0)
[23:21:55.000] Timer tick, asking Buildbucket for the build status
[23:21:55.164] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:55.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:12:0) after 1m0s
[23:22:55.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:12:0)
[23:22:55.198] Timer tick, asking Buildbucket for the build status
[23:22:56.874] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:56.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:13:0) after 1m0s
[23:23:56.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:13:0)
[23:23:56.956] Timer tick, asking Buildbucket for the build status
[23:23:57.087] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:57.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:14:0) after 1m0s
[23:24:57.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:14:0)
[23:24:57.126] Timer tick, asking Buildbucket for the build status
[23:24:57.315] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:57.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:15:0) after 1m0s
[23:25:57.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:15:0)
[23:25:57.355] Timer tick, asking Buildbucket for the build status
[23:25:57.871] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:57.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:16:0) after 1m0s
[23:26:57.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:16:0)
[23:26:57.917] Timer tick, asking Buildbucket for the build status
[23:26:58.034] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:58.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:17:0) after 1m0s
[23:27:58.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:17:0)
[23:27:58.096] Timer tick, asking Buildbucket for the build status
[23:27:58.206] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:58.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:18:0) after 1m0s
[23:28:58.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:18:0)
[23:28:58.213] Timer tick, asking Buildbucket for the build status
[23:28:58.265] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:58.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:19:0) after 1m0s
[23:29:58.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:19:0)
[23:29:58.288] Timer tick, asking Buildbucket for the build status
[23:29:58.348] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:58.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:20:0) after 1m0s
[23:30:58.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:20:0)
[23:30:58.369] Timer tick, asking Buildbucket for the build status
[23:30:58.539] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:58.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:21:0) after 1m0s
[23:31:58.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:21:0)
[23:31:58.588] Timer tick, asking Buildbucket for the build status
[23:31:58.699] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:58.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:22:0) after 1m0s
[23:32:58.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:22:0)
[23:32:58.738] Timer tick, asking Buildbucket for the build status
[23:32:58.907] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:58.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:23:0) after 1m0s
[23:33:58.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:23:0)
[23:33:58.984] Timer tick, asking Buildbucket for the build status
[23:33:59.099] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:59.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:24:0) after 1m0s
[23:34:59.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:24:0)
[23:34:59.262] Timer tick, asking Buildbucket for the build status
[23:34:59.354] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:59.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:25:0) after 1m0s
[23:35:59.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:25:0)
[23:35:59.496] Timer tick, asking Buildbucket for the build status
[23:35:59.624] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:59.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:26:0) after 1m0s
[23:36:59.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:26:0)
[23:36:59.658] Timer tick, asking Buildbucket for the build status
[23:36:59.803] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:59.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:27:0) after 1m0s
[23:37:59.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:27:0)
[23:37:59.804] Timer tick, asking Buildbucket for the build status
[23:37:59.979] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:59.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:28:0) after 1m0s
[23:39:00.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:28:0)
[23:39:00.093] Timer tick, asking Buildbucket for the build status
[23:39:00.327] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:00.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:29:0) after 1m0s
[23:40:00.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:29:0)
[23:40:00.349] Timer tick, asking Buildbucket for the build status
[23:40:00.592] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:00.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:30:0) after 1m0s
[23:41:00.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:30:0)
[23:41:00.701] Timer tick, asking Buildbucket for the build status
[23:41:01.103] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:01.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:31:0) after 1m0s
[23:42:01.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:31:0)
[23:42:01.168] Timer tick, asking Buildbucket for the build status
[23:42:01.229] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:01.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:32:0) after 1m0s
[23:43:01.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:32:0)
[23:43:01.269] Timer tick, asking Buildbucket for the build status
[23:43:01.373] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:01.373] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:33:0) after 1m0s
[23:44:01.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:33:0)
[23:44:01.475] Timer tick, asking Buildbucket for the build status
[23:44:01.563] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:01.563] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:34:0) after 1m0s
[23:45:01.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:34:0)
[23:45:01.562] Timer tick, asking Buildbucket for the build status
[23:45:01.634] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:01.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:35:0) after 1m0s
[23:46:01.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:35:0)
[23:46:01.686] Timer tick, asking Buildbucket for the build status
[23:46:01.792] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:01.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:36:0) after 1m0s
[23:47:01.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:36:0)
[23:47:01.838] Timer tick, asking Buildbucket for the build status
[23:47:01.990] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:01.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:37:0) after 1m0s
[23:48:02.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:37:0)
[23:48:02.013] Timer tick, asking Buildbucket for the build status
[23:48:02.176] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:02.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:38:0) after 1m0s
[23:49:02.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:38:0)
[23:49:02.323] Timer tick, asking Buildbucket for the build status
[23:49:02.405] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:02.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:39:0) after 1m0s
[23:50:02.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:39:0)
[23:50:02.423] Timer tick, asking Buildbucket for the build status
[23:50:02.558] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:02.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:40:0) after 1m0s
[23:51:02.578] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:40:0)
[23:51:02.578] Timer tick, asking Buildbucket for the build status
[23:51:02.713] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:02.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:41:0) after 1m0s
[23:52:02.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:41:0)
[23:52:02.787] Timer tick, asking Buildbucket for the build status
[23:52:02.851] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:02.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:42:0) after 1m0s
[23:53:02.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:42:0)
[23:53:02.882] Timer tick, asking Buildbucket for the build status
[23:53:03.093] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:03.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:43:0) after 1m0s
[23:54:03.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:43:0)
[23:54:03.250] Timer tick, asking Buildbucket for the build status
[23:54:03.420] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:03.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:44:0) after 1m0s
[23:55:03.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:44:0)
[23:55:03.441] Timer tick, asking Buildbucket for the build status
[23:55:03.511] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:03.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:45:0) after 1m0s
[23:56:03.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:45:0)
[23:56:03.600] Timer tick, asking Buildbucket for the build status
[23:56:03.839] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:03.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:46:0) after 1m0s
[23:57:03.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:46:0)
[23:57:03.857] Timer tick, asking Buildbucket for the build status
[23:57:03.995] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:03.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:47:0) after 1m0s
[23:58:04.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:47:0)
[23:58:04.036] Timer tick, asking Buildbucket for the build status
[23:58:04.468] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:04.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:48:0) after 1m0s
[23:59:04.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:48:0)
[23:59:04.492] Timer tick, asking Buildbucket for the build status
[23:59:05.383] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:05.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:49:0) after 1m0s
[00:00:05.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:49:0)
[00:00:05.487] Timer tick, asking Buildbucket for the build status
[00:00:06.288] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:06.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:50:0) after 1m0s
[00:01:06.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:50:0)
[00:01:06.270] Timer tick, asking Buildbucket for the build status
[00:01:06.937] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:06.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:51:0) after 1m0s
[00:02:06.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:51:0)
[00:02:06.974] Timer tick, asking Buildbucket for the build status
[00:02:07.097] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:07.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:52:0) after 1m0s
[00:03:07.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:52:0)
[00:03:07.147] Timer tick, asking Buildbucket for the build status
[00:03:07.572] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:07.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:53:0) after 1m0s
[00:04:07.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:53:0)
[00:04:07.591] Timer tick, asking Buildbucket for the build status
[00:04:07.670] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:07.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:54:0) after 1m0s
[00:05:07.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:54:0)
[00:05:07.743] Timer tick, asking Buildbucket for the build status
[00:05:07.925] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:07.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:55:0) after 1m0s
[00:06:07.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:55:0)
[00:06:07.955] Timer tick, asking Buildbucket for the build status
[00:06:08.033] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:08.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:56:0) after 1m0s
[00:07:08.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:56:0)
[00:07:08.082] Timer tick, asking Buildbucket for the build status
[00:07:09.304] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:09.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:57:0) after 1m0s
[00:08:09.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:57:0)
[00:08:09.326] Timer tick, asking Buildbucket for the build status
[00:08:09.494] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:09.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:58:0) after 1m0s
[00:09:09.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:58:0)
[00:09:09.544] Timer tick, asking Buildbucket for the build status
[00:09:09.628] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:09.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:59:0) after 1m0s
[00:10:09.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:59:0)
[00:10:09.704] Timer tick, asking Buildbucket for the build status
[00:10:09.827] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:09.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:60:0) after 1m0s
[00:11:09.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:60:0)
[00:11:09.882] Timer tick, asking Buildbucket for the build status
[00:11:09.977] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:09.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:61:0) after 1m0s
[00:12:10.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:61:0)
[00:12:10.008] Timer tick, asking Buildbucket for the build status
[00:12:10.203] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:10.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:62:0) after 1m0s
[00:13:10.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:62:0)
[00:13:10.336] Timer tick, asking Buildbucket for the build status
[00:13:10.551] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:10.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:63:0) after 1m0s
[00:14:10.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:63:0)
[00:14:10.601] Timer tick, asking Buildbucket for the build status
[00:14:10.716] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:10.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:64:0) after 1m0s
[00:15:10.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:64:0)
[00:15:10.747] Timer tick, asking Buildbucket for the build status
[00:15:10.903] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:10.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:65:0) after 1m0s
[00:16:10.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:65:0)
[00:16:10.926] Timer tick, asking Buildbucket for the build status
[00:16:11.078] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:11.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:66:0) after 1m0s
[00:17:11.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:66:0)
[00:17:11.163] Timer tick, asking Buildbucket for the build status
[00:17:11.642] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:11.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:67:0) after 1m0s
[00:18:12.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:67:0)
[00:18:12.075] Timer tick, asking Buildbucket for the build status
[00:18:12.221] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:12.221] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:68:0) after 1m0s
[00:19:12.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:68:0)
[00:19:12.225] Timer tick, asking Buildbucket for the build status
[00:19:12.315] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:12.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:69:0) after 1m0s
[00:20:12.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:69:0)
[00:20:12.377] Timer tick, asking Buildbucket for the build status
[00:20:12.774] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:12.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:70:0) after 1m0s
[00:21:12.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:70:0)
[00:21:12.797] Timer tick, asking Buildbucket for the build status
[00:21:13.014] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:13.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:71:0) after 1m0s
[00:22:13.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:71:0)
[00:22:13.038] Timer tick, asking Buildbucket for the build status
[00:22:13.132] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:13.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:72:0) after 1m0s
[00:23:13.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:72:0)
[00:23:13.137] Timer tick, asking Buildbucket for the build status
[00:23:13.513] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:13.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:73:0) after 1m0s
[00:24:13.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:73:0)
[00:24:13.553] Timer tick, asking Buildbucket for the build status
[00:24:13.673] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:13.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:74:0) after 1m0s
[00:25:13.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:74:0)
[00:25:13.736] Timer tick, asking Buildbucket for the build status
[00:25:13.844] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:13.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:75:0) after 1m0s
[00:26:13.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:75:0)
[00:26:13.935] Timer tick, asking Buildbucket for the build status
[00:26:14.072] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:14.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:76:0) after 1m0s
[00:27:14.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:76:0)
[00:27:14.184] Timer tick, asking Buildbucket for the build status
[00:27:14.270] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:14.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:77:0) after 1m0s
[00:28:14.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:77:0)
[00:28:14.374] Timer tick, asking Buildbucket for the build status
[00:28:14.539] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:14.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:78:0) after 1m0s
[00:29:14.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:78:0)
[00:29:14.564] Timer tick, asking Buildbucket for the build status
[00:29:14.719] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:14.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:79:0) after 1m0s
[00:30:14.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:79:0)
[00:30:14.759] Timer tick, asking Buildbucket for the build status
[00:30:16.869] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:16.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:80:0) after 1m0s
[00:31:16.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:80:0)
[00:31:16.975] Timer tick, asking Buildbucket for the build status
[00:31:17.047] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:17.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:81:0) after 1m0s
[00:32:17.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:81:0)
[00:32:17.143] Timer tick, asking Buildbucket for the build status
[00:32:17.266] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:17.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:82:0) after 1m0s
[00:33:17.289] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:82:0)
[00:33:17.289] Timer tick, asking Buildbucket for the build status
[00:33:17.473] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:17.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:83:0) after 1m0s
[00:34:17.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:83:0)
[00:34:17.586] Timer tick, asking Buildbucket for the build status
[00:34:17.718] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:17.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:84:0) after 1m0s
[00:35:17.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:84:0)
[00:35:17.902] Timer tick, asking Buildbucket for the build status
[00:35:17.962] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:17.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:85:0) after 1m0s
[00:36:18.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:85:0)
[00:36:18.055] Timer tick, asking Buildbucket for the build status
[00:36:18.128] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:18.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:86:0) after 1m0s
[00:37:18.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:86:0)
[00:37:18.168] Timer tick, asking Buildbucket for the build status
[00:37:18.284] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:18.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:87:0) after 1m0s
[00:38:18.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:87:0)
[00:38:18.478] Timer tick, asking Buildbucket for the build status
[00:38:18.607] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:18.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:88:0) after 1m0s
[00:39:18.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:88:0)
[00:39:18.636] Timer tick, asking Buildbucket for the build status
[00:39:19.027] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:19.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:89:0) after 1m0s
[00:40:19.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:89:0)
[00:40:19.689] Timer tick, asking Buildbucket for the build status
[00:40:20.064] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:20.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:90:0) after 1m0s
[00:41:20.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:90:0)
[00:41:20.156] Timer tick, asking Buildbucket for the build status
[00:41:20.544] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:20.544] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:91:0) after 1m0s
[00:42:20.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:91:0)
[00:42:20.858] Timer tick, asking Buildbucket for the build status
[00:42:21.031] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:21.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:92:0) after 1m0s
[00:43:21.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:92:0)
[00:43:21.043] Timer tick, asking Buildbucket for the build status
[00:43:21.246] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:21.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:93:0) after 1m0s
[00:44:21.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:93:0)
[00:44:21.267] Timer tick, asking Buildbucket for the build status
[00:44:21.400] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:21.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:94:0) after 1m0s
[00:45:21.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:94:0)
[00:45:21.499] Timer tick, asking Buildbucket for the build status
[00:45:21.680] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:21.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:95:0) after 1m0s
[00:46:21.804] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:95:0)
[00:46:21.804] Timer tick, asking Buildbucket for the build status
[00:46:22.025] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:22.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:96:0) after 1m0s
[00:47:22.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:96:0)
[00:47:22.040] Timer tick, asking Buildbucket for the build status
[00:47:22.229] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:22.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:97:0) after 1m0s
[00:48:22.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:97:0)
[00:48:22.309] Timer tick, asking Buildbucket for the build status
[00:48:22.497] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:22.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:98:0) after 1m0s
[00:49:22.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:98:0)
[00:49:22.628] Timer tick, asking Buildbucket for the build status
[00:49:22.762] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:22.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:99:0) after 1m0s
[00:50:22.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:99:0)
[00:50:22.846] Timer tick, asking Buildbucket for the build status
[00:50:23.287] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:23.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:100:0) after 1m0s
[00:51:23.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:100:0)
[00:51:23.381] Timer tick, asking Buildbucket for the build status
[00:51:23.999] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:23.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:101:0) after 1m0s
[00:52:24.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:101:0)
[00:52:24.231] Timer tick, asking Buildbucket for the build status
[00:52:24.521] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:24.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:102:0) after 1m0s
[00:53:24.542] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:102:0)
[00:53:24.542] Timer tick, asking Buildbucket for the build status
[00:53:24.678] Build 8862164899099940768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:24.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027594961140922688:103:0) after 1m0s
[00:54:17.913] Received PubSub notification, asking Buildbucket for the build status
[00:54:18.026] Build 8862164899099940768: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:54:18.026] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1606784056877378",
"created_by": "project:chromium",
"created_ts": "1606777970179012",
"id": "8862164899099940768",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11be620585749c6d1e1b2fac4d5bb39550d3dd58\"}}",
"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\": \"11be620585749c6d1e1b2fac4d5bb39550d3dd58\", \"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-158-dnw9\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43319, \"got_angle_revision\": \"619ae0038825cfc8c53ba50e292d2930af7f8cd8\", \"got_dawn_revision\": \"6a7095d8c75373e363d52faed3c74f517ca7311f\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"11be620585749c6d1e1b2fac4d5bb39550d3dd58\", \"got_revision_cp\": \"refs/heads/master@{#832063}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"1eadcfb3be99c2eca944774a78c4e3c16132958b\", \"got_v8_revision\": \"779fa622348c3fab46d3337764c3eaf19e684a42\", \"got_v8_revision_cp\": \"refs/heads/8.9.70@{#1}\", \"got_webrtc_revision\": \"bcca3b08a90fccaa6dd8d86f6079f0ca0553ab4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32715}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11be620585749c6d1e1b2fac4d5bb39550d3dd58\", \"swarm_hashes_refs/heads/master(at){#832063}_without_patch\": {\"absl_hardening_tests\": \"42f855e5117850c4083b4a27568a980c70d4fefa\", \"accessibility_unittests\": \"067d79d2e60da345ca57f20b9028803bf13a0aaa\", \"angle_unittests\": \"1821c87d3ae9d08e2e378884fdfd85aeac635e53\", \"app_list_unittests\": \"d5533fa0c7f027de3d22fc617da02eb61a64257b\", \"app_shell_unittests\": \"9a2323341d890d8747dfb0b9648765bf6287657a\", \"ash_unittests\": \"05c9a62d3065da3e3a23d49738524b7bf25b903e\", \"aura_unittests\": \"90b42a4e9bcebaecac88b958ae5edcded5dce1b5\", \"base_unittests\": \"9b5e4b39c512670f7f24a6335a4acbb068191640\", \"base_util_unittests\": \"43707bacf8f735edca8ae478f63062ca3278e7a2\", \"blink_common_unittests\": \"9f77286b706c2458d9838b1df014edeee668957d\", \"blink_fuzzer_unittests\": \"667ff450679d8564b896655528e577c28484c0ae\", \"blink_heap_unittests\": \"d16cd2af02b72f76badb47cc34fdd36fba42dd01\", \"blink_platform_unittests\": \"4e8bc5691ea60ac38b181e9ef5f2f2a3d0077ef4\", \"blink_unittests\": \"5395b42aebc72eff5e6acf621f0199d85dfd2c5e\", \"boringssl_crypto_tests\": \"f5294bf1f50ca96b06d14ee8baf34efc8cb767e7\", \"boringssl_ssl_tests\": \"d4ed35a23af4946f4dffa3f478946f656bebe508\", \"browser_tests\": \"67feacc3f070253c58d1ecf1af832ed745cfe509\", \"capture_unittests\": \"8254d9a1122c38b630c03b7cfe70d6ac125df7e8\", \"cast_unittests\": \"2ebd6000769ae349f1d0cd780196a79ea3f695ab\", \"cc_unittests\": \"0177e1f6beea289f8e76828d65834f97b983f72a\", \"chrome_app_unittests\": \"d92657276f457b9330b69c016fd5d72a869787ca\", \"chromedriver_unittests\": \"11dffa8c7e3e0bc42e869bde1d6a746277f4c89a\", \"chromeos_components_unittests\": \"4a5137c99d33371fc1d3838ff99bc7f1f7604704\", \"chromeos_unittests\": \"70e04a0ecce6726dbaf7f9fa958680e73ad47507\", \"components_browsertests\": \"6bb1231669bb05fc011779e440b088835a8b6a69\", \"components_unittests\": \"d6b5e52af4b8abadde4a3de2efe8518456e512b2\", \"compositor_unittests\": \"d3a2585e704361d55a898d72854a87cc769d31e9\", \"content_browsertests\": \"5aa693d967186b8730ac9610a8fbc27b23eab94c\", \"content_unittests\": \"05e8706a0543cc466d883c1412d673718a7d45a3\", \"crashpad_tests\": \"2c3c96ac250d0a78be64c4241d6ec4620b0588fc\", \"crypto_unittests\": \"0d0a6925264db776fa92f92043ad5b6bb2a7f266\", \"dbus_unittests\": \"c4fc02eed74803084fc4b3a6be61d05deed6e9ce\", \"device_unittests\": \"6a5ed2ebb33f75e9964612087c0e698da0a02879\", \"display_unittests\": \"59c2ad3a44a8ba8d2094bee08d0d5b1a1c83b1c7\", \"events_unittests\": \"a037272b3884b7d235249e64fd8e4c6f7cac181b\", \"exo_unittests\": \"1320863a8fdef6864729c5d387674592e256c810\", \"extensions_browsertests\": \"b5c9da1d63185e9e342f76de6c4898a7997fad77\", \"extensions_unittests\": \"0920fa8638fe63ccf5b3687ad452a86a8a9de9a0\", \"filesystem_service_unittests\": \"35aeff1ab34b5e8730d116843598f7c0e60e7c0d\", \"gcm_unit_tests\": \"4d2b70ff408fa49922eea4605160f3248874c7ed\", \"gfx_unittests\": \"8b266768dacccebb5dcf7898ddebfdeace5d6dbf\", \"gin_unittests\": \"bd51a502fcb74e2f2d3e6cb89f99249725af6cc4\", \"gl_unittests_ozone\": \"dbff1cf7b199c769c662907a4368582d1e4c8aee\", \"google_apis_unittests\": \"9ccc2a51919ff71d56cd5e8775ac1f7cb3b78a0d\", \"gpu_unittests\": \"a23323d125ce80945796e13d8eca8ac6deabd689\", \"gwp_asan_unittests\": \"75b4e33b64de4e38b39c62196b34a6ce0b9307fe\", \"interactive_ui_tests\": \"725abc5f8e4111d8edbdfbc2e04e6d1640f155ad\", \"ipc_tests\": \"100f769148f12912fcc4fa25d65221b96639106f\", \"jingle_unittests\": \"1bdc499f32bfe9b63a3ebe9ded652aac3f649d1b\", \"keyboard_unittests\": \"4b46475a6f732d61865a54aac9f30d57b288db0e\", \"latency_unittests\": \"a8e2439d1af03748a5f13b1a4bb5a30d62f6d9c3\", \"libjingle_xmpp_unittests\": \"774116d00476b727af3270704fe82ff154edb9e3\", \"liburlpattern_unittests\": \"a4b31b30c065e3fcaf5c2007d485f4df63b74b9a\", \"media_blink_unittests\": \"ee574782383cbe1e8c1b28566e8e5f750b891b5d\", \"media_unittests\": \"413a94a79a97ca74c7a1965fe638cc1671f1cbcc\", \"message_center_unittests\": \"ee187371879917a5dd7df49a82398040a42fff11\", \"midi_unittests\": \"e77a85cc03e081461b9a3f00de5bf3d25a3af9fe\", \"mojo_core_unittests\": \"7592bf35411c9686bf514d37ec87ed8f6f28efa5\", \"mojo_unittests\": \"20f4873071f544ee7e61a0e6a16a44238b789d38\", \"nacl_helper_nonsfi_unittests\": \"b8386024954834dc3029bdce6a1016e1b4db8b7f\", \"nacl_loader_unittests\": \"0587b00e90a5818a307325097e21faae67200231\", \"native_theme_unittests\": \"999d11eb91b701017747f921cb25c8e3d55ce486\", \"net_unittests\": \"683e60ba3a4935794242c75c591b42b0a4e1dbeb\", \"ozone_gl_unittests\": \"0876c28e4a51021d9eba04d137940ffade5a1aba\", \"ozone_unittests\": \"7c2a748e0353bffcd1d4879806c99a1e34240ff8\", \"ozone_x11_unittests\": \"7c81dbd58f4231a909578b72d826b282246c9533\", \"pdf_unittests\": \"ce1d2214dce61f8eff0480f1d9f4d2df5d0ff1f1\", \"perfetto_unittests\": \"d6ffb351b82818989d5767cbd6a50c83236332dc\", \"ppapi_unittests\": \"20ca67bf1203fdd9b7892429365c082d4b5229b6\", \"printing_unittests\": \"91adf946bf8070166308c35e18b64b8ade2b1ad1\", \"remoting_unittests\": \"04a9959743b144cfaedf15a3cbeda760f35be405\", \"sandbox_linux_unittests\": \"8a07fffefe7bea9ab8f38a225f6705ad9f5dd773\", \"service_manager_unittests\": \"ab97ee28d32555c37b4b7ce172285257dcacf27b\", \"services_unittests\": \"4cbf22d7c53a8072e13069fc2105af7e14570295\", \"shell_dialogs_unittests\": \"73a0859f80bc9b9d45563457ca70e06458d1af2e\", \"skia_unittests\": \"6c2f51b86791a4e309033e1fdbe4a1df2d346b13\", \"snapshot_unittests\": \"06ec77e0cf278f2a55f4de358afc5b2852479638\", \"sql_unittests\": \"1fc6570e1e92f8917bf8cd7af560cc52d989e88d\", \"storage_unittests\": \"2f72b19daf848d4e150cb95e0aa82dc38648749d\", \"sync_integration_tests\": \"42afacbbe14cfa7d8c262bc2643437cdeb98af36\", \"traffic_annotation_auditor_unittests\": \"462382cf99037964fb17bc46c2681c82fa4e9fcf\", \"ui_base_unittests\": \"a535b9f344b9aa211845a3dc3dcf00bc14bd2074\", \"ui_chromeos_unittests\": \"52275e13d950111d75513a5d1f3156286a5ed831\", \"ui_touch_selection_unittests\": \"3846b2f6aa5146e815f286254f5a6c2f8539400e\", \"unit_tests\": \"eb91578055b2b743e8b8ca53381c5f91340b65ff\", \"url_unittests\": \"eaa03495e60814214dc271dfa5a9aef9c2e0053d\", \"usage_time_limit_unittests\": \"55e5e79e79ef66a0e1f6c4af6d9e10e613dc7b39\", \"views_unittests\": \"bcd0efad73e88cd455740b4a30dd82fd57892c7e\", \"viz_unittests\": \"87970c49cac243e14bcdbb5adfd4b22ec879f563\", \"wayland_client_perftests\": \"2ee3537884b56be6f91e76ff3f424685f33b20f1\", \"wm_unittests\": \"f947739af32f773cbdf0c5e8440a102e64bd294a\", \"wtf_unittests\": \"a49cffd313cd1eb24fb2833aaf9938923240a95d\", \"zlib_unittests\": \"d2a7bbefb983fed362999e7b15739137d529f808\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_6887d226fea03ae8e203d0a1d4c9e197b929dd99abf2bafb38063e06e39bc1ba_v2\", \"builder_78080097a3960c8831291638a631c67e272aa3d821d469cd7fbf44d1ce982b94_v2\", \"builder_79ddf9721ca7b7ce79374811fb2c516b44ee31d85deee669f4d7a1736cefaf3b_v2\", \"builder_8e35dc9d0a811a7a5937b2845f7d6ff611dfc73c6ea10d73e1df62dc95746f2a_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"builder_b13f895f2fa532c56bcd54736f154d6ea330771f795358111cd0095a10831ab4_v2\", \"builder_b347f6763adaa44ed1b4895a094f35f1b15f20643e3eba38abfdc8f27ff2117b_v2\", \"builder_befd2764f389ab60d591810dc88de7e503142ac60c144228b6731720c84dd23a_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-158-dnw9\"], \"image\": [\"chrome-xenial-20112200-f7cdea8df03\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1606778225333355",
"status": "COMPLETED",
"status_changed_ts": "1606784057207991",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43319",
"builder:linux-chromeos-rel",
"buildset:commit/git/11be620585749c6d1e1b2fac4d5bb39550d3dd58",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11be620585749c6d1e1b2fac4d5bb39550d3dd58",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027594961140922688",
"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/8862164899099940768/+/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:50343fae80837910",
"user_agent:luci-scheduler"
],
"updated_ts": "1606784057213672",
"url": "https://ci.chromium.org/b/8862164899099940768",
"utcnow_ts": "1606784058013951"
}
}
[00:54:18.026] Invocation finished in 1h41m29.176823915s with status SUCCEEDED