[13:43:56.659] New invocation is queued and will start shortly
[13:43:57.874] Starting the invocation (attempt 1)
[13:43:57.911] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:43:57.911] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:43:57.912] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027177766520503952",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"794bb39841624a0cf2bb3175fd16a469d5f4558c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9027177766520503952",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/794bb39841624a0cf2bb3175fd16a469d5f4558c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/794bb39841624a0cf2bb3175fd16a469d5f4558c",
"gitiles_ref:refs/heads/master"
]
}
[13:43:58.886] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607175838002553",
"id": "8861747704449699344",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"794bb39841624a0cf2bb3175fd16a469d5f4558c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607175838571226",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43464",
"builder:linux-chromeos-rel",
"buildset:commit/git/794bb39841624a0cf2bb3175fd16a469d5f4558c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/794bb39841624a0cf2bb3175fd16a469d5f4558c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027177766520503952",
"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/8861747704449699344/+/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": "1607175838571354",
"url": "https://ci.chromium.org/b/8861747704449699344",
"utcnow_ts": "1607175838853451"
}
}
[13:43:58.886] Task URL: https://ci.chromium.org/b/8861747704449699344
[13:43:58.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:2:0) after 1m0s
[13:44:58.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:2:0)
[13:44:58.918] Timer tick, asking Buildbucket for the build status
[13:45:09.408] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:45:09.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:3:0) after 1m0s
[13:46:09.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:3:0)
[13:46:09.632] Timer tick, asking Buildbucket for the build status
[13:46:11.057] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:46:11.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:4:0) after 1m0s
[13:47:11.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:4:0)
[13:47:11.058] Timer tick, asking Buildbucket for the build status
[13:47:11.155] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:47:11.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:5:0) after 1m0s
[13:48:11.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:5:0)
[13:48:11.262] Timer tick, asking Buildbucket for the build status
[13:48:11.436] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:48:11.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:6:0) after 1m0s
[13:49:11.512] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:6:0)
[13:49:11.512] Timer tick, asking Buildbucket for the build status
[13:49:11.918] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:49:11.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:7:0) after 1m0s
[13:50:12.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:7:0)
[13:50:12.025] Timer tick, asking Buildbucket for the build status
[13:50:20.148] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:50:20.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:8:0) after 1m0s
[13:51:20.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:8:0)
[13:51:20.228] Timer tick, asking Buildbucket for the build status
[13:51:21.834] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:51:21.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:9:0) after 1m0s
[13:52:21.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:9:0)
[13:52:21.903] Timer tick, asking Buildbucket for the build status
[13:52:22.549] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:52:22.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:10:0) after 1m0s
[13:53:22.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:10:0)
[13:53:22.659] Timer tick, asking Buildbucket for the build status
[13:53:23.349] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:53:23.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:11:0) after 1m0s
[13:54:23.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:11:0)
[13:54:23.368] Timer tick, asking Buildbucket for the build status
[13:54:23.849] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:54:23.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:12:0) after 1m0s
[13:55:23.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:12:0)
[13:55:23.979] Timer tick, asking Buildbucket for the build status
[13:55:30.074] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:55:30.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:13:0) after 1m0s
[13:56:30.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:13:0)
[13:56:30.299] Timer tick, asking Buildbucket for the build status
[13:56:30.385] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:56:30.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:14:0) after 1m0s
[13:57:30.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:14:0)
[13:57:30.426] Timer tick, asking Buildbucket for the build status
[13:57:30.539] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:57:30.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:15:0) after 1m0s
[13:58:30.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:15:0)
[13:58:30.788] Timer tick, asking Buildbucket for the build status
[13:58:31.322] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:58:31.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:16:0) after 1m0s
[13:59:31.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:16:0)
[13:59:31.529] Timer tick, asking Buildbucket for the build status
[13:59:31.658] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:59:31.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:17:0) after 1m0s
[14:00:31.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:17:0)
[14:00:31.755] Timer tick, asking Buildbucket for the build status
[14:00:32.044] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:00:32.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:18:0) after 1m0s
[14:01:32.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:18:0)
[14:01:32.135] Timer tick, asking Buildbucket for the build status
[14:01:32.831] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:01:32.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:19:0) after 1m0s
[14:02:32.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:19:0)
[14:02:32.872] Timer tick, asking Buildbucket for the build status
[14:02:33.733] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:02:33.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:20:0) after 1m0s
[14:03:33.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:20:0)
[14:03:33.971] Timer tick, asking Buildbucket for the build status
[14:03:34.242] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:03:34.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:21:0) after 1m0s
[14:04:34.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:21:0)
[14:04:34.268] Timer tick, asking Buildbucket for the build status
[14:04:34.562] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:04:34.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:22:0) after 1m0s
[14:05:44.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:22:0)
[14:05:44.963] Timer tick, asking Buildbucket for the build status
[14:05:56.023] Build 8861747704449699344: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:05:56.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:23:0) after 1m0s
[14:06:45.995] Received PubSub notification, asking Buildbucket for the build status
[14:06:46.354] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:56.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:23:0)
[14:06:56.161] Timer tick, asking Buildbucket for the build status
[14:06:56.592] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:56.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:25:0) after 1m0s
[14:07:56.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:25:0)
[14:07:56.666] Timer tick, asking Buildbucket for the build status
[14:07:56.778] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:56.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:26:0) after 1m0s
[14:08:56.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:26:0)
[14:08:56.997] Timer tick, asking Buildbucket for the build status
[14:08:57.343] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:57.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:27:0) after 1m0s
[14:09:57.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:27:0)
[14:09:57.349] Timer tick, asking Buildbucket for the build status
[14:09:57.614] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:57.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:28:0) after 1m0s
[14:10:57.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:28:0)
[14:10:57.877] Timer tick, asking Buildbucket for the build status
[14:11:04.686] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:04.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:29:0) after 1m0s
[14:12:04.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:29:0)
[14:12:04.706] Timer tick, asking Buildbucket for the build status
[14:12:05.708] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:05.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:30:0) after 1m0s
[14:13:05.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:30:0)
[14:13:05.727] Timer tick, asking Buildbucket for the build status
[14:13:05.831] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:05.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:31:0) after 1m0s
[14:14:05.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:31:0)
[14:14:05.803] Timer tick, asking Buildbucket for the build status
[14:14:06.974] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:06.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:32:0) after 1m0s
[14:15:07.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:32:0)
[14:15:07.045] Timer tick, asking Buildbucket for the build status
[14:15:07.430] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:07.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:33:0) after 1m0s
[14:16:07.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:33:0)
[14:16:07.505] Timer tick, asking Buildbucket for the build status
[14:16:08.843] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:08.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:34:0) after 1m0s
[14:17:09.020] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:34:0)
[14:17:09.020] Timer tick, asking Buildbucket for the build status
[14:17:09.627] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:09.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:35:0) after 1m0s
[14:18:09.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:35:0)
[14:18:09.757] Timer tick, asking Buildbucket for the build status
[14:18:09.871] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:09.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:36:0) after 1m0s
[14:19:09.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:36:0)
[14:19:09.866] Timer tick, asking Buildbucket for the build status
[14:19:11.359] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:11.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:37:0) after 1m0s
[14:20:11.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:37:0)
[14:20:11.593] Timer tick, asking Buildbucket for the build status
[14:20:12.230] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:12.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:38:0) after 1m0s
[14:21:12.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:38:0)
[14:21:12.273] Timer tick, asking Buildbucket for the build status
[14:21:24.089] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:24.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:39:0) after 1m0s
[14:22:24.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:39:0)
[14:22:24.109] Timer tick, asking Buildbucket for the build status
[14:22:25.303] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:25.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:40:0) after 1m0s
[14:23:25.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:40:0)
[14:23:25.514] Timer tick, asking Buildbucket for the build status
[14:23:25.944] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:25.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:41:0) after 1m0s
[14:24:26.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:41:0)
[14:24:26.163] Timer tick, asking Buildbucket for the build status
[14:24:26.601] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:26.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:42:0) after 1m0s
[14:25:26.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:42:0)
[14:25:26.723] Timer tick, asking Buildbucket for the build status
[14:25:26.814] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:26.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:43:0) after 1m0s
[14:26:27.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:43:0)
[14:26:27.008] Timer tick, asking Buildbucket for the build status
[14:26:27.422] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:27.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:44:0) after 1m0s
[14:27:27.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:44:0)
[14:27:27.440] Timer tick, asking Buildbucket for the build status
[14:27:27.582] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:27.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:45:0) after 1m0s
[14:28:27.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:45:0)
[14:28:27.634] Timer tick, asking Buildbucket for the build status
[14:28:27.867] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:27.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:46:0) after 1m0s
[14:29:27.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:46:0)
[14:29:27.900] Timer tick, asking Buildbucket for the build status
[14:29:28.183] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:28.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:47:0) after 1m0s
[14:30:28.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:47:0)
[14:30:28.255] Timer tick, asking Buildbucket for the build status
[14:30:28.436] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:28.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:48:0) after 1m0s
[14:31:28.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:48:0)
[14:31:28.443] Timer tick, asking Buildbucket for the build status
[14:31:28.961] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:28.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:49:0) after 1m0s
[14:32:28.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:49:0)
[14:32:28.955] Timer tick, asking Buildbucket for the build status
[14:32:29.215] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:29.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:50:0) after 1m0s
[14:33:29.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:50:0)
[14:33:29.239] Timer tick, asking Buildbucket for the build status
[14:33:30.251] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:30.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:51:0) after 1m0s
[14:34:30.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:51:0)
[14:34:30.288] Timer tick, asking Buildbucket for the build status
[14:34:31.564] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:31.564] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:52:0) after 1m0s
[14:35:31.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:52:0)
[14:35:31.552] Timer tick, asking Buildbucket for the build status
[14:35:32.615] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:32.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:53:0) after 1m0s
[14:36:32.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:53:0)
[14:36:32.674] Timer tick, asking Buildbucket for the build status
[14:36:33.115] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:33.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:54:0) after 1m0s
[14:37:33.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:54:0)
[14:37:33.139] Timer tick, asking Buildbucket for the build status
[14:37:36.965] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:36.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:55:0) after 1m0s
[14:38:37.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:55:0)
[14:38:37.024] Timer tick, asking Buildbucket for the build status
[14:38:37.181] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:37.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:56:0) after 1m0s
[14:39:37.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:56:0)
[14:39:37.234] Timer tick, asking Buildbucket for the build status
[14:39:37.439] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:37.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:57:0) after 1m0s
[14:40:37.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:57:0)
[14:40:37.491] Timer tick, asking Buildbucket for the build status
[14:40:38.404] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:38.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:58:0) after 1m0s
[14:41:38.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:58:0)
[14:41:38.521] Timer tick, asking Buildbucket for the build status
[14:41:38.591] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:38.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:59:0) after 1m0s
[14:42:38.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:59:0)
[14:42:38.845] Timer tick, asking Buildbucket for the build status
[14:42:40.799] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:40.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:60:0) after 1m0s
[14:43:40.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:60:0)
[14:43:40.823] Timer tick, asking Buildbucket for the build status
[14:43:41.115] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:41.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:61:0) after 1m0s
[14:44:41.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:61:0)
[14:44:41.137] Timer tick, asking Buildbucket for the build status
[14:44:41.296] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:41.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:62:0) after 1m0s
[14:45:41.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:62:0)
[14:45:41.272] Timer tick, asking Buildbucket for the build status
[14:45:41.383] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:41.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:63:0) after 1m0s
[14:46:41.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:63:0)
[14:46:41.439] Timer tick, asking Buildbucket for the build status
[14:46:42.064] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:42.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:64:0) after 1m0s
[14:47:42.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:64:0)
[14:47:42.079] Timer tick, asking Buildbucket for the build status
[14:47:42.249] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:42.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:65:0) after 1m0s
[14:48:42.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:65:0)
[14:48:42.267] Timer tick, asking Buildbucket for the build status
[14:48:42.350] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:42.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:66:0) after 1m0s
[14:49:42.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:66:0)
[14:49:42.374] Timer tick, asking Buildbucket for the build status
[14:49:42.818] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:42.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:67:0) after 1m0s
[14:50:42.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:67:0)
[14:50:42.838] Timer tick, asking Buildbucket for the build status
[14:50:42.950] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:42.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:68:0) after 1m0s
[14:51:43.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:68:0)
[14:51:43.021] Timer tick, asking Buildbucket for the build status
[14:51:43.588] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:43.588] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:69:0) after 1m0s
[14:52:43.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:69:0)
[14:52:43.639] Timer tick, asking Buildbucket for the build status
[14:52:44.410] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:44.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:70:0) after 1m0s
[14:53:44.473] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:70:0)
[14:53:44.473] Timer tick, asking Buildbucket for the build status
[14:53:45.928] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:45.928] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:71:0) after 1m0s
[14:54:45.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:71:0)
[14:54:45.954] Timer tick, asking Buildbucket for the build status
[14:54:46.354] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:46.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:72:0) after 1m0s
[14:55:46.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:72:0)
[14:55:46.475] Timer tick, asking Buildbucket for the build status
[14:55:46.560] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:46.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:73:0) after 1m0s
[14:56:46.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:73:0)
[14:56:46.615] Timer tick, asking Buildbucket for the build status
[14:56:46.693] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:46.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:74:0) after 1m0s
[14:57:46.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:74:0)
[14:57:46.826] Timer tick, asking Buildbucket for the build status
[14:57:46.969] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:46.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:75:0) after 1m0s
[14:58:47.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:75:0)
[14:58:47.145] Timer tick, asking Buildbucket for the build status
[14:58:50.617] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:50.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:76:0) after 1m0s
[14:59:50.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:76:0)
[14:59:50.637] Timer tick, asking Buildbucket for the build status
[14:59:50.778] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:50.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:77:0) after 1m0s
[15:00:50.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:77:0)
[15:00:50.889] Timer tick, asking Buildbucket for the build status
[15:00:50.960] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:50.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:78:0) after 1m0s
[15:01:50.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:78:0)
[15:01:50.942] Timer tick, asking Buildbucket for the build status
[15:01:51.287] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:51.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:79:0) after 1m0s
[15:02:51.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:79:0)
[15:02:51.380] Timer tick, asking Buildbucket for the build status
[15:02:51.526] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:51.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:80:0) after 1m0s
[15:03:51.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:80:0)
[15:03:51.567] Timer tick, asking Buildbucket for the build status
[15:03:51.944] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:51.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:81:0) after 1m0s
[15:04:51.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:81:0)
[15:04:51.970] Timer tick, asking Buildbucket for the build status
[15:05:07.860] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:07.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:82:0) after 1m0s
[15:06:07.846] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:82:0)
[15:06:07.846] Timer tick, asking Buildbucket for the build status
[15:06:08.250] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:08.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:83:0) after 1m0s
[15:07:08.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:83:0)
[15:07:08.243] Timer tick, asking Buildbucket for the build status
[15:07:08.322] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:08.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:84:0) after 1m0s
[15:08:08.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:84:0)
[15:08:08.377] Timer tick, asking Buildbucket for the build status
[15:08:10.082] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:10.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:85:0) after 1m0s
[15:09:10.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:85:0)
[15:09:10.176] Timer tick, asking Buildbucket for the build status
[15:09:10.278] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:10.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:86:0) after 1m0s
[15:10:10.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:86:0)
[15:10:10.308] Timer tick, asking Buildbucket for the build status
[15:10:10.430] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:10.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:87:0) after 1m0s
[15:11:10.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:87:0)
[15:11:10.465] Timer tick, asking Buildbucket for the build status
[15:11:10.651] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:10.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:88:0) after 1m0s
[15:12:10.717] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:88:0)
[15:12:10.717] Timer tick, asking Buildbucket for the build status
[15:12:10.905] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:10.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:89:0) after 1m0s
[15:13:10.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:89:0)
[15:13:10.982] Timer tick, asking Buildbucket for the build status
[15:13:11.276] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:11.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:90:0) after 1m0s
[15:14:11.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:90:0)
[15:14:11.568] Timer tick, asking Buildbucket for the build status
[15:14:11.857] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:11.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:91:0) after 1m0s
[15:15:11.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:91:0)
[15:15:11.966] Timer tick, asking Buildbucket for the build status
[15:15:12.676] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:12.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:92:0) after 1m0s
[15:16:12.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:92:0)
[15:16:12.685] Timer tick, asking Buildbucket for the build status
[15:16:14.636] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:14.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:93:0) after 1m0s
[15:17:14.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:93:0)
[15:17:14.753] Timer tick, asking Buildbucket for the build status
[15:17:16.459] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:16.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:94:0) after 1m0s
[15:18:16.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:94:0)
[15:18:16.517] Timer tick, asking Buildbucket for the build status
[15:18:17.144] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:17.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:95:0) after 1m0s
[15:19:17.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:95:0)
[15:19:17.172] Timer tick, asking Buildbucket for the build status
[15:19:19.309] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:19.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:96:0) after 1m0s
[15:20:19.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:96:0)
[15:20:19.328] Timer tick, asking Buildbucket for the build status
[15:20:19.503] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:19.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:97:0) after 1m0s
[15:21:19.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:97:0)
[15:21:19.550] Timer tick, asking Buildbucket for the build status
[15:21:22.348] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:22.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:98:0) after 1m0s
[15:22:22.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:98:0)
[15:22:22.425] Timer tick, asking Buildbucket for the build status
[15:22:22.945] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:22.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:99:0) after 1m0s
[15:23:22.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:99:0)
[15:23:22.981] Timer tick, asking Buildbucket for the build status
[15:23:23.198] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:23.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:100:0) after 1m0s
[15:24:23.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:100:0)
[15:24:23.271] Timer tick, asking Buildbucket for the build status
[15:24:23.963] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:23.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:101:0) after 1m0s
[15:25:23.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:101:0)
[15:25:23.985] Timer tick, asking Buildbucket for the build status
[15:25:25.772] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:25.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:102:0) after 1m0s
[15:26:25.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:102:0)
[15:26:25.900] Timer tick, asking Buildbucket for the build status
[15:26:31.945] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:31.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:103:0) after 1m0s
[15:27:32.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:103:0)
[15:27:32.022] Timer tick, asking Buildbucket for the build status
[15:27:32.502] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:32.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:104:0) after 1m0s
[15:28:32.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:104:0)
[15:28:32.594] Timer tick, asking Buildbucket for the build status
[15:28:32.908] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:32.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:105:0) after 1m0s
[15:29:33.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:105:0)
[15:29:33.090] Timer tick, asking Buildbucket for the build status
[15:29:33.437] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:33.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:106:0) after 1m0s
[15:30:33.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:106:0)
[15:30:33.454] Timer tick, asking Buildbucket for the build status
[15:30:33.579] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:33.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:107:0) after 1m0s
[15:31:33.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:107:0)
[15:31:33.650] Timer tick, asking Buildbucket for the build status
[15:31:39.345] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:39.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:108:0) after 1m0s
[15:32:39.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:108:0)
[15:32:39.366] Timer tick, asking Buildbucket for the build status
[15:32:39.763] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:39.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:109:0) after 1m0s
[15:33:39.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:109:0)
[15:33:39.795] Timer tick, asking Buildbucket for the build status
[15:33:39.983] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:39.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:110:0) after 1m0s
[15:34:40.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:110:0)
[15:34:40.036] Timer tick, asking Buildbucket for the build status
[15:34:40.198] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:40.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:111:0) after 1m0s
[15:35:40.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:111:0)
[15:35:40.256] Timer tick, asking Buildbucket for the build status
[15:35:40.889] Build 8861747704449699344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:40.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9027177766520503952:112:0) after 1m0s
[15:36:24.548] Received PubSub notification, asking Buildbucket for the build status
[15:36:24.625] Build 8861747704449699344: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[15:36:24.625] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607182580717456",
"created_by": "project:chromium",
"created_ts": "1607175838002553",
"id": "8861747704449699344",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"794bb39841624a0cf2bb3175fd16a469d5f4558c\"}}",
"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\": \"794bb39841624a0cf2bb3175fd16a469d5f4558c\", \"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-98-kroj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 43464, \"got_angle_revision\": \"251ba5cb119ff2fed0e861cbc9b096c45004c1fa\", \"got_dawn_revision\": \"c532048062befdee8bb57d18f01d3a3c403d49de\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"794bb39841624a0cf2bb3175fd16a469d5f4558c\", \"got_revision_cp\": \"refs/heads/master@{#834019}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"f36e874ade1dbc6f5ddfc857753a892a8bb358c3\", \"got_v8_revision\": \"61f3e61408129afc0d9e1268d3354a283ea3c881\", \"got_v8_revision_cp\": \"refs/heads/8.9.100@{#1}\", \"got_webrtc_revision\": \"6c80aebd00360ee00c84c7b14422c5fe475d8916\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32774}\", \"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\": \"794bb39841624a0cf2bb3175fd16a469d5f4558c\", \"swarm_hashes_refs/heads/master(at){#834019}_without_patch\": {\"absl_hardening_tests\": \"6d06764c2431c4875220577096afaa6c709f8332\", \"accessibility_unittests\": \"d42e03c1a82e88e0b49adbcb20b5ed6e005e7177\", \"angle_unittests\": \"1d863ea3a24ad5e531aca65e256221d70ab6e030\", \"app_list_unittests\": \"e4c60842f1a903c66c7fd7532ce0e562f8b49c76\", \"app_shell_unittests\": \"1adb0b0af7d14f1f20015609969da7118aead680\", \"ash_unittests\": \"ca5ebb9bcaa830f7a1f8b03854d1d0a3b8a4d5ab\", \"aura_unittests\": \"4617684ae57efec1028de96300c321e117699f9b\", \"base_unittests\": \"33550542f5f4d612138ad8776f375fc57ceb4cf7\", \"base_util_unittests\": \"2e8be2d69133587afc998c3423a631d6546c4b62\", \"blink_common_unittests\": \"c4e8a6a03fe9acb69e8c6990d9f9df30e93c443e\", \"blink_fuzzer_unittests\": \"3c6e7077aa4a074650fbb168df58e62fff2d0d50\", \"blink_heap_unittests\": \"d80fcfa998c5e7c3be0801d024ff7779ac513f06\", \"blink_platform_unittests\": \"98d3d334c55387a9308bdd2cb455a58c200868d2\", \"blink_unittests\": \"025105dde6643dcec968e55a5246870d2ff39478\", \"boringssl_crypto_tests\": \"049e786d677d2c3d67cd485881ca983eb5f374ef\", \"boringssl_ssl_tests\": \"67f17125db496d440235f2b7a1d398485a22677e\", \"browser_tests\": \"85b04ff2ed52f012415ba7da3d94c7d1b287cce5\", \"capture_unittests\": \"c8e6bd54acb5c07c03be4f1fe24903ae887c82f1\", \"cast_unittests\": \"eaea77aacc813c5b2007a27e12617da5644aa882\", \"cc_unittests\": \"fcaff35cef687509668ad1ff6834ef95df1cfb0d\", \"chrome_app_unittests\": \"b2f4c1f040e59945998b9accaf93702dd8242a79\", \"chromedriver_unittests\": \"e87cd021862398aaa5f58b34d609c3fda95c75e3\", \"chromeos_components_unittests\": \"a36c5e637b448089b1377dc4121e06e24bd6de4d\", \"chromeos_unittests\": \"246970f1ff650347c14220a2b63f34385cd7e34f\", \"components_browsertests\": \"988e4cbb3499811e9be34e3f568231b757beedf2\", \"components_unittests\": \"ab6dba8cdf4f3df22c7e5a9340ce49e20874eb32\", \"compositor_unittests\": \"2a8f16aff3214b24800250316f1eaf254528cd0c\", \"content_browsertests\": \"61a7b25cafb6a27e289552a0506f3f8705a154b8\", \"content_unittests\": \"f30ff25cd0d6dbcfd1c7af00c4ba61112c21be92\", \"crashpad_tests\": \"63be958f8cdb8566e6a62bb9dc96485914758a02\", \"crypto_unittests\": \"4a56221996fc424edd008d1874ec6b0d5f2cbd8f\", \"dbus_unittests\": \"26c9bc7318d656d92f4114c8a7e79a7104a642fe\", \"device_unittests\": \"a33309daa262f74d8b2199bdd232e66b14714cc4\", \"display_unittests\": \"da3fce6f5bbd1e0ca44033715d9c499b8aabed84\", \"events_unittests\": \"90b724fd84d3b128ca1822d9e0bce38cf7b04b6d\", \"exo_unittests\": \"ec499c688de65252e8a8da4c6a5617eb325c856d\", \"extensions_browsertests\": \"8b668a55609da223050725079d59bfd621925bba\", \"extensions_unittests\": \"a4b20e37d1c82a518e15c59f53b636a14725fdbb\", \"filesystem_service_unittests\": \"14d98e911bd890fa0e82b0931bfdddfdf6b28ab2\", \"gcm_unit_tests\": \"a36a54eaf2303fb7ff796759daf2a20e686685aa\", \"gfx_unittests\": \"0245fe721db7986fc4bf019a332840e5ad32fd9b\", \"gin_unittests\": \"24590cb2470635e64d58a11b90ccdc3ef9a6a8ce\", \"gl_unittests_ozone\": \"6005a84b8efbcb7691d2e6fedefcb5dd400b7da4\", \"google_apis_unittests\": \"1723f0683a46c7a2397d81c2d362bfbda50afff8\", \"gpu_unittests\": \"8350d559f5f3f37897bfc2324e8464a689c13abf\", \"gwp_asan_unittests\": \"7cc6a64de41098c96d401e1cbb53c59f1dc669ec\", \"interactive_ui_tests\": \"694c6d391ffe8495a3b69946079118bbe96551bb\", \"ipc_tests\": \"f3dcfd406da1e3ff61da80a5e49734af54efe535\", \"jingle_unittests\": \"b75259d18cb4a34197d3422f09c3a3af4baf5060\", \"keyboard_unittests\": \"eb583de5c78edf407106ad4b39dc073ab6221091\", \"latency_unittests\": \"48478afe8b520cd35b81cf7a76f991f56dd1a169\", \"libjingle_xmpp_unittests\": \"1479ecd1c01feb17dbc2f2c1298e39c57622dc4e\", \"liburlpattern_unittests\": \"88c1d773d027f8cb642ae0b597ee9201cdc53759\", \"media_blink_unittests\": \"0a1e4b177fc4be1453b8c41dac3fc89cb104437d\", \"media_unittests\": \"a32bcaad7dea1abffb89d4a082f72014d8209e9a\", \"message_center_unittests\": \"f415a1badd4de0cda879b3471fe76551179f63b2\", \"midi_unittests\": \"a91db25bd493154b235041cffb681a8c456e6113\", \"mojo_core_unittests\": \"d43b3498cfe1e7d077eeaa13361fe3d972f57aea\", \"mojo_unittests\": \"3ce3a49dcbf48ac9e6713588216bf6ad50b30892\", \"nacl_helper_nonsfi_unittests\": \"2c1ef58341ff106449306546e51708e7885584e7\", \"nacl_loader_unittests\": \"86ebdbb4e6c39b03e3d66b8f500d5980a2d653dc\", \"native_theme_unittests\": \"348a0fda78b91ebf0bcbdebcf6975f6197844646\", \"net_unittests\": \"95eac12244fd8a58fd76761cf46dad2508e99a60\", \"ozone_gl_unittests\": \"8d82fa5ffa2b58ca8a2d790b0542ea527ce47dc4\", \"ozone_unittests\": \"5cac27a1cfe5cb80ad7cc61bb085dc001fd13251\", \"ozone_x11_unittests\": \"d37c785f93fe53c37974fd389406b2b69b74fd42\", \"pdf_unittests\": \"1a0e15c52fd13fbeddbe6158d13ddb5b3c4ca24f\", \"perfetto_unittests\": \"d5e8fd00e704b1d16ddc1eda81de9c208d670a1a\", \"ppapi_unittests\": \"8ccae8adb07bb53f1bf469fbfa8a9382f5394c7e\", \"printing_unittests\": \"c3fc06cdde2e538162eeb4d1d5c12f9bbe82935e\", \"remoting_unittests\": \"216efbfa0098d91862cc554111b07f743c941efc\", \"sandbox_linux_unittests\": \"a4a3614355f5c1a2e341fac584f8f7b8a78237c8\", \"service_manager_unittests\": \"09b2cfa73b28d3d1d1a104b3e4c043494fc190c3\", \"services_unittests\": \"ca2aa872bcbb729e030dfe8f6f84dd09b468e5bc\", \"shell_dialogs_unittests\": \"12ca7036783fe480f32a1b7c8427efa24b8d1eaf\", \"shell_encryption_unittests\": \"c83859fef7b69e7ce05ea1f25fc45534d5b3a290\", \"skia_unittests\": \"4da8e22a25f5d721baa94697ac2008dae06109b3\", \"snapshot_unittests\": \"63163249716bd5a180be37e177b95b6167a2ea6d\", \"sql_unittests\": \"336c6b6d609f688633e14a938137cb1bc1426a88\", \"storage_unittests\": \"319019edb9d51ab4481d130b74c86fd7668c9d57\", \"sync_integration_tests\": \"8e3ceae8c11cc7e0065aaf60331f8a02e2f09062\", \"traffic_annotation_auditor_unittests\": \"74219727c67ae1af246e49e43ed4a6a88a99c318\", \"ui_base_unittests\": \"4cf912d16d0a5c9a43bd22816d352c6f8b9d0bd4\", \"ui_chromeos_unittests\": \"e793126f478cc0d729ddf160ca112b3f7f5b1347\", \"ui_touch_selection_unittests\": \"8a994a7a87215a8856d6bc2f0779c20f1d4e3233\", \"unit_tests\": \"619c2f9479b7bf69a344db17be84a35c3c6f87e5\", \"url_unittests\": \"23231d68c3ccf0c19814bd5333386f7cefc1f49c\", \"usage_time_limit_unittests\": \"2e755c378a86de361f80e473b6a1cc8ec2b206a9\", \"views_unittests\": \"1766c8d101809bde055905b4ca981610b39304cb\", \"viz_unittests\": \"318215334e573527a61e53d04f983cddcbb97b01\", \"wayland_client_perftests\": \"3124f45ae278b975ef31c9b48ebe63ce6e830fc2\", \"wm_unittests\": \"e20fabe97905b958ff7fe480388f87c329b823c7\", \"wtf_unittests\": \"a1d35d2d0886320cc812ea40d1ebdfdbcb1ca25f\", \"zlib_unittests\": \"eaff9779b98c7fb14dd536444ca3c1a054cf45d1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_28be8b4e850be8bd7a9db0671ff876681ccdf0c2c048860e172c20e0c8b9b79b_v2\", \"builder_2924decd8bf92d66d12e0f7871729cd28b590c544e302b2201ef1e5b1ad96b76_v2\", \"builder_36c8846ac28dcb92a60d8a88629bcaff3f7fc5fe5317cfbc320487dfb1197cd9_v2\", \"builder_b624744545b53f30069a9e0f9d655dd80cb0688eb6f8753c5d4d1f02e2478691_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_v2\", \"builder_d0ba3cd99c36b697d8651140d51bf4b4f4b9cd9aa25af11363af5ede5f6e35b1_v2\", \"builder_dbb86507a6c3fadd4cf4e1827f5f960c6207016e30a949100a00998d3583e722_v2\", \"builder_ded6992437bb43fbf38c4db56f613c83c13b8efc5129044b4fc05fb02888bbc4_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-98-kroj\"], \"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": "1607177204812707",
"status": "COMPLETED",
"status_changed_ts": "1607182583973211",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/43464",
"builder:linux-chromeos-rel",
"buildset:commit/git/794bb39841624a0cf2bb3175fd16a469d5f4558c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/794bb39841624a0cf2bb3175fd16a469d5f4558c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027177766520503952",
"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/8861747704449699344/+/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:504bf6a4c0b19510",
"user_agent:luci-scheduler"
],
"updated_ts": "1607182583977907",
"url": "https://ci.chromium.org/b/8861747704449699344",
"utcnow_ts": "1607182584615497"
}
}
[15:36:24.626] Invocation finished in 1h52m27.982347031s with status SUCCEEDED