[15:25:09.685] New invocation is queued and will start shortly
[15:25:11.093] Starting the invocation (attempt 1)
[15:25:11.134] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:25:11.134] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:25:11.134] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030885874114657776",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c2c354c3e10e196e279d60bd90c46aa222579737\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9030885874114657776",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/c2c354c3e10e196e279d60bd90c46aa222579737",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c2c354c3e10e196e279d60bd90c46aa222579737",
"gitiles_ref:refs/heads/master"
]
}
[15:25:11.755] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603639511228057",
"id": "8865455811833236640",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c2c354c3e10e196e279d60bd90c46aa222579737\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603639511617216",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42244",
"builder:linux-chromeos-rel",
"buildset:commit/git/c2c354c3e10e196e279d60bd90c46aa222579737",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c2c354c3e10e196e279d60bd90c46aa222579737",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030885874114657776",
"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/8865455811833236640/+/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": "1603639511617361",
"url": "https://ci.chromium.org/b/8865455811833236640",
"utcnow_ts": "1603639511746874"
}
}
[15:25:11.755] Task URL: https://ci.chromium.org/b/8865455811833236640
[15:25:11.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:2:0) after 1m0s
[15:26:11.782] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:2:0)
[15:26:11.782] Timer tick, asking Buildbucket for the build status
[15:26:11.918] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:26:11.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:3:0) after 1m0s
[15:27:11.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:3:0)
[15:27:11.913] Timer tick, asking Buildbucket for the build status
[15:27:12.029] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:27:12.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:4:0) after 1m0s
[15:28:12.135] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:4:0)
[15:28:12.135] Timer tick, asking Buildbucket for the build status
[15:28:12.256] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:28:12.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:5:0) after 1m0s
[15:29:12.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:5:0)
[15:29:12.384] Timer tick, asking Buildbucket for the build status
[15:29:12.751] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:29:12.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:6:0) after 1m0s
[15:30:12.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:6:0)
[15:30:12.730] Timer tick, asking Buildbucket for the build status
[15:30:12.918] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:30:12.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:7:0) after 1m0s
[15:31:12.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:7:0)
[15:31:12.943] Timer tick, asking Buildbucket for the build status
[15:31:13.199] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:31:13.199] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:8:0) after 1m0s
[15:32:13.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:8:0)
[15:32:13.327] Timer tick, asking Buildbucket for the build status
[15:32:13.405] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:32:13.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:9:0) after 1m0s
[15:33:13.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:9:0)
[15:33:13.673] Timer tick, asking Buildbucket for the build status
[15:33:13.784] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:33:13.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:10:0) after 1m0s
[15:34:14.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:10:0)
[15:34:14.045] Timer tick, asking Buildbucket for the build status
[15:34:14.131] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:34:14.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:11:0) after 1m0s
[15:35:14.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:11:0)
[15:35:14.302] Timer tick, asking Buildbucket for the build status
[15:35:14.444] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:35:14.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:12:0) after 1m0s
[15:36:14.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:12:0)
[15:36:14.537] Timer tick, asking Buildbucket for the build status
[15:36:14.648] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:36:14.648] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:13:0) after 1m0s
[15:37:14.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:13:0)
[15:37:14.712] Timer tick, asking Buildbucket for the build status
[15:37:14.783] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:37:14.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:14:0) after 1m0s
[15:38:14.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:14:0)
[15:38:14.949] Timer tick, asking Buildbucket for the build status
[15:38:15.026] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:38:15.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:15:0) after 1m0s
[15:39:15.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:15:0)
[15:39:15.065] Timer tick, asking Buildbucket for the build status
[15:39:15.387] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:39:15.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:16:0) after 1m0s
[15:40:15.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:16:0)
[15:40:15.556] Timer tick, asking Buildbucket for the build status
[15:40:15.796] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:40:15.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:17:0) after 1m0s
[15:41:15.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:17:0)
[15:41:15.778] Timer tick, asking Buildbucket for the build status
[15:41:15.942] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:41:15.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:18:0) after 1m0s
[15:42:16.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:18:0)
[15:42:16.019] Timer tick, asking Buildbucket for the build status
[15:42:16.192] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:42:16.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:19:0) after 1m0s
[15:43:16.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:19:0)
[15:43:16.326] Timer tick, asking Buildbucket for the build status
[15:43:16.395] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:43:16.395] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:20:0) after 1m0s
[15:44:16.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:20:0)
[15:44:16.517] Timer tick, asking Buildbucket for the build status
[15:44:16.792] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:44:16.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:21:0) after 1m0s
[15:45:16.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:21:0)
[15:45:16.855] Timer tick, asking Buildbucket for the build status
[15:45:16.971] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:45:16.971] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:22:0) after 1m0s
[15:46:16.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:22:0)
[15:46:16.994] Timer tick, asking Buildbucket for the build status
[15:46:17.236] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:46:17.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:23:0) after 1m0s
[15:47:17.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:23:0)
[15:47:17.256] Timer tick, asking Buildbucket for the build status
[15:47:17.414] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:47:17.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:24:0) after 1m0s
[15:48:17.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:24:0)
[15:48:17.586] Timer tick, asking Buildbucket for the build status
[15:48:17.726] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:48:17.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:25:0) after 1m0s
[15:49:17.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:25:0)
[15:49:17.750] Timer tick, asking Buildbucket for the build status
[15:49:17.842] Build 8865455811833236640: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[15:49:17.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:26:0) after 1m0s
[15:49:38.961] Received PubSub notification, asking Buildbucket for the build status
[15:49:39.203] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:17.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:26:0)
[15:50:17.981] Timer tick, asking Buildbucket for the build status
[15:50:18.105] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:18.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:28:0) after 1m0s
[15:51:18.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:28:0)
[15:51:18.251] Timer tick, asking Buildbucket for the build status
[15:51:18.346] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:18.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:29:0) after 1m0s
[15:52:18.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:29:0)
[15:52:18.408] Timer tick, asking Buildbucket for the build status
[15:52:18.590] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:18.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:30:0) after 1m0s
[15:53:18.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:30:0)
[15:53:18.644] Timer tick, asking Buildbucket for the build status
[15:53:18.810] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:18.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:31:0) after 1m0s
[15:54:18.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:31:0)
[15:54:18.903] Timer tick, asking Buildbucket for the build status
[15:54:19.272] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:19.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:32:0) after 1m0s
[15:55:19.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:32:0)
[15:55:19.397] Timer tick, asking Buildbucket for the build status
[15:55:19.530] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:19.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:33:0) after 1m0s
[15:56:19.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:33:0)
[15:56:19.588] Timer tick, asking Buildbucket for the build status
[15:56:19.755] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:19.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:34:0) after 1m0s
[15:57:19.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:34:0)
[15:57:19.858] Timer tick, asking Buildbucket for the build status
[15:57:20.106] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:20.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:35:0) after 1m0s
[15:58:20.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:35:0)
[15:58:20.287] Timer tick, asking Buildbucket for the build status
[15:58:20.456] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:20.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:36:0) after 1m0s
[15:59:20.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:36:0)
[15:59:20.596] Timer tick, asking Buildbucket for the build status
[15:59:20.665] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:20.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:37:0) after 1m0s
[16:00:20.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:37:0)
[16:00:20.910] Timer tick, asking Buildbucket for the build status
[16:00:21.043] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:21.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:38:0) after 1m0s
[16:01:21.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:38:0)
[16:01:21.206] Timer tick, asking Buildbucket for the build status
[16:01:21.277] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:21.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:39:0) after 1m0s
[16:02:21.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:39:0)
[16:02:21.526] Timer tick, asking Buildbucket for the build status
[16:02:21.813] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:21.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:40:0) after 1m0s
[16:03:21.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:40:0)
[16:03:21.950] Timer tick, asking Buildbucket for the build status
[16:03:22.059] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:22.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:41:0) after 1m0s
[16:04:22.150] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:41:0)
[16:04:22.150] Timer tick, asking Buildbucket for the build status
[16:04:22.295] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:22.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:42:0) after 1m0s
[16:05:22.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:42:0)
[16:05:22.357] Timer tick, asking Buildbucket for the build status
[16:05:22.464] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:22.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:43:0) after 1m0s
[16:06:22.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:43:0)
[16:06:22.458] Timer tick, asking Buildbucket for the build status
[16:06:22.547] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:22.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:44:0) after 1m0s
[16:07:22.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:44:0)
[16:07:22.607] Timer tick, asking Buildbucket for the build status
[16:07:22.676] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:22.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:45:0) after 1m0s
[16:08:22.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:45:0)
[16:08:22.813] Timer tick, asking Buildbucket for the build status
[16:08:22.901] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:22.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:46:0) after 1m0s
[16:09:23.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:46:0)
[16:09:23.009] Timer tick, asking Buildbucket for the build status
[16:09:23.075] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:23.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:47:0) after 1m0s
[16:10:23.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:47:0)
[16:10:23.148] Timer tick, asking Buildbucket for the build status
[16:10:23.254] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:23.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:48:0) after 1m0s
[16:11:23.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:48:0)
[16:11:23.354] Timer tick, asking Buildbucket for the build status
[16:11:24.332] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:24.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:49:0) after 1m0s
[16:12:24.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:49:0)
[16:12:24.361] Timer tick, asking Buildbucket for the build status
[16:12:24.519] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:24.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:50:0) after 1m0s
[16:13:24.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:50:0)
[16:13:24.550] Timer tick, asking Buildbucket for the build status
[16:13:24.617] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:24.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:51:0) after 1m0s
[16:14:24.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:51:0)
[16:14:24.688] Timer tick, asking Buildbucket for the build status
[16:14:24.903] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:24.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:52:0) after 1m0s
[16:15:25.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:52:0)
[16:15:25.004] Timer tick, asking Buildbucket for the build status
[16:15:25.152] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:25.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:53:0) after 1m0s
[16:16:25.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:53:0)
[16:16:25.243] Timer tick, asking Buildbucket for the build status
[16:16:25.316] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:25.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:54:0) after 1m0s
[16:17:25.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:54:0)
[16:17:25.440] Timer tick, asking Buildbucket for the build status
[16:17:25.498] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:25.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:55:0) after 1m0s
[16:18:25.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:55:0)
[16:18:25.595] Timer tick, asking Buildbucket for the build status
[16:18:25.660] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:25.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:56:0) after 1m0s
[16:19:25.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:56:0)
[16:19:25.802] Timer tick, asking Buildbucket for the build status
[16:19:25.865] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:25.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:57:0) after 1m0s
[16:20:25.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:57:0)
[16:20:25.978] Timer tick, asking Buildbucket for the build status
[16:20:26.093] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:26.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:58:0) after 1m0s
[16:21:26.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:58:0)
[16:21:26.213] Timer tick, asking Buildbucket for the build status
[16:21:26.278] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:26.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:59:0) after 1m0s
[16:22:26.369] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:59:0)
[16:22:26.369] Timer tick, asking Buildbucket for the build status
[16:22:26.500] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:26.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:60:0) after 1m0s
[16:23:26.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:60:0)
[16:23:26.556] Timer tick, asking Buildbucket for the build status
[16:23:26.615] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:26.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:61:0) after 1m0s
[16:24:26.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:61:0)
[16:24:26.643] Timer tick, asking Buildbucket for the build status
[16:24:26.906] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:26.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:62:0) after 1m0s
[16:25:26.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:62:0)
[16:25:26.993] Timer tick, asking Buildbucket for the build status
[16:25:27.121] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:27.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:63:0) after 1m0s
[16:26:27.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:63:0)
[16:26:27.248] Timer tick, asking Buildbucket for the build status
[16:26:27.306] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:27.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:64:0) after 1m0s
[16:27:27.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:64:0)
[16:27:27.440] Timer tick, asking Buildbucket for the build status
[16:27:27.506] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:27.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:65:0) after 1m0s
[16:28:27.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:65:0)
[16:28:27.634] Timer tick, asking Buildbucket for the build status
[16:28:27.699] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:27.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:66:0) after 1m0s
[16:29:27.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:66:0)
[16:29:27.828] Timer tick, asking Buildbucket for the build status
[16:29:27.886] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:27.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:67:0) after 1m0s
[16:30:27.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:67:0)
[16:30:27.985] Timer tick, asking Buildbucket for the build status
[16:30:28.096] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:28.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:68:0) after 1m0s
[16:31:28.120] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:68:0)
[16:31:28.120] Timer tick, asking Buildbucket for the build status
[16:31:28.180] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:28.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:69:0) after 1m0s
[16:32:28.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:69:0)
[16:32:28.283] Timer tick, asking Buildbucket for the build status
[16:32:28.350] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:28.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:70:0) after 1m0s
[16:33:28.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:70:0)
[16:33:28.513] Timer tick, asking Buildbucket for the build status
[16:33:28.666] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:28.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:71:0) after 1m0s
[16:34:28.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:71:0)
[16:34:28.699] Timer tick, asking Buildbucket for the build status
[16:34:28.761] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:28.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:72:0) after 1m0s
[16:35:28.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:72:0)
[16:35:28.849] Timer tick, asking Buildbucket for the build status
[16:35:28.966] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:28.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:73:0) after 1m0s
[16:36:28.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:73:0)
[16:36:28.968] Timer tick, asking Buildbucket for the build status
[16:36:29.042] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:29.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:74:0) after 1m0s
[16:37:29.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:74:0)
[16:37:29.083] Timer tick, asking Buildbucket for the build status
[16:37:29.441] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:29.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:75:0) after 1m0s
[16:38:29.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:75:0)
[16:38:29.461] Timer tick, asking Buildbucket for the build status
[16:38:29.603] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:29.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:76:0) after 1m0s
[16:39:29.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:76:0)
[16:39:29.678] Timer tick, asking Buildbucket for the build status
[16:39:30.010] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:30.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:77:0) after 1m0s
[16:40:30.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:77:0)
[16:40:30.068] Timer tick, asking Buildbucket for the build status
[16:40:30.460] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:30.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:78:0) after 1m0s
[16:41:30.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:78:0)
[16:41:30.623] Timer tick, asking Buildbucket for the build status
[16:41:30.694] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:30.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:79:0) after 1m0s
[16:42:30.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:79:0)
[16:42:30.864] Timer tick, asking Buildbucket for the build status
[16:42:30.925] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:30.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:80:0) after 1m0s
[16:43:30.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:80:0)
[16:43:30.996] Timer tick, asking Buildbucket for the build status
[16:43:31.070] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:31.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:81:0) after 1m0s
[16:44:31.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:81:0)
[16:44:31.094] Timer tick, asking Buildbucket for the build status
[16:44:31.222] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:31.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:82:0) after 1m0s
[16:45:31.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:82:0)
[16:45:31.222] Timer tick, asking Buildbucket for the build status
[16:45:31.328] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:31.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:83:0) after 1m0s
[16:46:31.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:83:0)
[16:46:31.352] Timer tick, asking Buildbucket for the build status
[16:46:31.868] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:31.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:84:0) after 1m0s
[16:47:31.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:84:0)
[16:47:31.852] Timer tick, asking Buildbucket for the build status
[16:47:32.142] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:32.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:85:0) after 1m0s
[16:48:32.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:85:0)
[16:48:32.158] Timer tick, asking Buildbucket for the build status
[16:48:32.225] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:32.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:86:0) after 1m0s
[16:49:32.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:86:0)
[16:49:32.240] Timer tick, asking Buildbucket for the build status
[16:49:32.297] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:32.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:87:0) after 1m0s
[16:50:32.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:87:0)
[16:50:32.324] Timer tick, asking Buildbucket for the build status
[16:50:32.448] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:32.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:88:0) after 1m0s
[16:51:32.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:88:0)
[16:51:32.469] Timer tick, asking Buildbucket for the build status
[16:51:32.533] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:32.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:89:0) after 1m0s
[16:52:32.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:89:0)
[16:52:32.554] Timer tick, asking Buildbucket for the build status
[16:52:32.636] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:32.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:90:0) after 1m0s
[16:53:32.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:90:0)
[16:53:32.663] Timer tick, asking Buildbucket for the build status
[16:53:33.083] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:33.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:91:0) after 1m0s
[16:54:33.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:91:0)
[16:54:33.194] Timer tick, asking Buildbucket for the build status
[16:54:33.425] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:33.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:92:0) after 1m0s
[16:55:33.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:92:0)
[16:55:33.454] Timer tick, asking Buildbucket for the build status
[16:55:33.685] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:33.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:93:0) after 1m0s
[16:56:33.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:93:0)
[16:56:33.681] Timer tick, asking Buildbucket for the build status
[16:56:33.841] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:33.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:94:0) after 1m0s
[16:57:33.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:94:0)
[16:57:33.886] Timer tick, asking Buildbucket for the build status
[16:57:33.993] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:33.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:95:0) after 1m0s
[16:58:34.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:95:0)
[16:58:34.017] Timer tick, asking Buildbucket for the build status
[16:58:34.193] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:34.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:96:0) after 1m0s
[16:59:34.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:96:0)
[16:59:34.228] Timer tick, asking Buildbucket for the build status
[16:59:34.344] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:34.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:97:0) after 1m0s
[17:00:34.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:97:0)
[17:00:34.400] Timer tick, asking Buildbucket for the build status
[17:00:34.903] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:34.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:98:0) after 1m0s
[17:01:34.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:98:0)
[17:01:34.959] Timer tick, asking Buildbucket for the build status
[17:01:35.070] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:35.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:99:0) after 1m0s
[17:02:35.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:99:0)
[17:02:35.099] Timer tick, asking Buildbucket for the build status
[17:02:35.209] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:35.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:100:0) after 1m0s
[17:03:35.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:100:0)
[17:03:35.244] Timer tick, asking Buildbucket for the build status
[17:03:35.656] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:35.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:101:0) after 1m0s
[17:04:35.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:101:0)
[17:04:35.683] Timer tick, asking Buildbucket for the build status
[17:04:36.291] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:36.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:102:0) after 1m0s
[17:05:36.326] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:102:0)
[17:05:36.326] Timer tick, asking Buildbucket for the build status
[17:05:36.739] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:36.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:103:0) after 1m0s
[17:06:36.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:103:0)
[17:06:36.745] Timer tick, asking Buildbucket for the build status
[17:06:36.849] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:36.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:104:0) after 1m0s
[17:07:36.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:104:0)
[17:07:36.881] Timer tick, asking Buildbucket for the build status
[17:07:36.987] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:36.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:105:0) after 1m0s
[17:08:37.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:105:0)
[17:08:37.046] Timer tick, asking Buildbucket for the build status
[17:08:37.153] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:37.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:106:0) after 1m0s
[17:09:37.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:106:0)
[17:09:37.179] Timer tick, asking Buildbucket for the build status
[17:09:37.786] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:37.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:107:0) after 1m0s
[17:10:37.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:107:0)
[17:10:37.881] Timer tick, asking Buildbucket for the build status
[17:10:37.997] Build 8865455811833236640: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:37.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030885874114657776:108:0) after 1m0s
[17:11:13.400] Received PubSub notification, asking Buildbucket for the build status
[17:11:13.473] Build 8865455811833236640: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:11:13.474] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603645871984039",
"created_by": "project:chromium",
"created_ts": "1603639511228057",
"id": "8865455811833236640",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c2c354c3e10e196e279d60bd90c46aa222579737\"}}",
"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\": \"c2c354c3e10e196e279d60bd90c46aa222579737\", \"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-east1-d-8-61-durd\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42244, \"got_angle_revision\": \"7a0263547cda936b320d80c650b69d7522ee1a9f\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"c2c354c3e10e196e279d60bd90c46aa222579737\", \"got_revision_cp\": \"refs/heads/master@{#820618}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"73fe59b55662be0ff07e79da1ece8b9e42415dca\", \"got_v8_revision_cp\": \"refs/heads/8.8.171@{#1}\", \"got_webrtc_revision\": \"e6fa238f76e50a8caa0547074f75443bbfd7b986\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32482}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c2c354c3e10e196e279d60bd90c46aa222579737\", \"swarm_hashes_refs/heads/master(at){#820618}_without_patch\": {\"absl_hardening_tests\": \"688545d994f6532d7f0b85189d8f075c04666cf9\", \"accessibility_unittests\": \"3fd668c03d0b326bcee7017f62235b26b345e964\", \"angle_unittests\": \"edf535c474337c6c4dfe3adea646df621b9c5ee1\", \"app_list_unittests\": \"3ed70e3f5913cd404a0071c60327422e42059dee\", \"app_shell_unittests\": \"9414f023f6cd1d16da21132dc9969e40d9abc007\", \"ash_unittests\": \"0caef93becb207a7a760dc82da142cca4016afc8\", \"aura_unittests\": \"aac96678a7aae39b10573296c1a0f41c4b9b3d11\", \"base_unittests\": \"b09c045939ac0f926d03a4cd13aea2a3e9399128\", \"base_util_unittests\": \"663d99147321ca41b0dc4bdd5e9016d09cd69722\", \"blink_common_unittests\": \"94dc8bc5e884f651a97c174a31855aebf2ca5456\", \"blink_fuzzer_unittests\": \"960cb38bcc71891a97ff551a1fa6d92ce38fc390\", \"blink_heap_unittests\": \"53d6ad7e3d5f4583845ff32fb1c34b46254edc3c\", \"blink_platform_unittests\": \"3a24630f51bb46d09093b1a34a83db5871bd43f9\", \"blink_unittests\": \"5e14d0077d2d7066471b82058e13fddd1be4e59a\", \"boringssl_crypto_tests\": \"5623290ab35bb3a9e56d9c02ef041d8399cb2408\", \"boringssl_ssl_tests\": \"890ac51bfa579d02ed27dbcd8425714c0af2ed42\", \"browser_tests\": \"84e6649f3142038d65f3bee6634fff05f6589e41\", \"capture_unittests\": \"04bfe3c05f1a1d4cd2d11264f8c10ebcba1b543b\", \"cast_unittests\": \"4d5478da926fcfe829ba9aea65666298d03b1ed4\", \"cc_unittests\": \"e0807593ed743baf2fd49b6cbb78cae6d566e57c\", \"chrome_app_unittests\": \"8d6536664fefc90c7a6b37fb4bd3b3c29ae20790\", \"chromedriver_unittests\": \"5bd8757524fd93b193fcbd43cd12ecf7d049986c\", \"chromeos_components_unittests\": \"58a5c83ce32f31cdc95b77b0a81ed57e5c4aa159\", \"chromeos_unittests\": \"b8c87b2fdea851b6f032c20e285adad1d5138912\", \"components_browsertests\": \"848a72bcf10869c7f74e1b69dd9d093e974ed003\", \"components_unittests\": \"a88f5448982fa3e4c6bec582c21ee9b8a9fa64a0\", \"compositor_unittests\": \"4b0df5a5e60318ab6a184c758b461dbf7587f218\", \"content_browsertests\": \"3ca83c49067c82568124b6b197cb72fd3947c0b8\", \"content_unittests\": \"45e47c08f30936ed21be7301516632370d693670\", \"crypto_unittests\": \"1b5dd23cfac7a6653dad131544295ff13eba92c5\", \"dbus_unittests\": \"8eb7d227c09c9fa029fee5cb948fe3cca71708d8\", \"device_unittests\": \"1107ce1319a4e4a0345f91ab7eb492767193ca04\", \"display_unittests\": \"ca5bc9425fb7bc3959ba38e0ec687444c29d55db\", \"events_unittests\": \"b388d6e04ad5c8c35c709e2ea61e48dad37d32c6\", \"exo_unittests\": \"5077f4a041c20947cc307b70da57559997d5d8a3\", \"extensions_browsertests\": \"7a18738261b41608d38a3f50a040654d70f7af93\", \"extensions_unittests\": \"9a2401f1d97d4b7f5a1d05d4b3b52299f6b3b90e\", \"filesystem_service_unittests\": \"110cea0c2c474c12e8804765745c3297684ec362\", \"gcm_unit_tests\": \"e3fdee2867e650f1329e2f610ecaee59e2a4b75f\", \"gfx_unittests\": \"59752702bcb0e34b00d2c58bfa8f184402eb9ae9\", \"gin_unittests\": \"6b5f99ec5703e0e7e7dd1e745326042351302b7b\", \"gl_unittests_ozone\": \"a69d12785d5ce2acfe0f71bfa39a5f35a4d656b1\", \"google_apis_unittests\": \"3755fdba12a83b5e35a50ea12362ab3b38dc9498\", \"gpu_unittests\": \"219aed20a360d09b57fe4529123c0361ef5e2b75\", \"gwp_asan_unittests\": \"48e4085ea948aef88fec7f62fb96e8d5e9420e29\", \"interactive_ui_tests\": \"341d0635ad4549804c54f4b155ac611f616f15b7\", \"ipc_tests\": \"3d79c078491eee4c48ed631d4fd4154808480700\", \"jingle_unittests\": \"450528fc7493d85aa692e4cd7cadcdc3bff3dcff\", \"keyboard_unittests\": \"98b9eeda4dda7b70e3937098d9b4298bbe0e609c\", \"latency_unittests\": \"13b1e20efd05c0c57537ddf5f28fb4d58acbf6ac\", \"libjingle_xmpp_unittests\": \"1266a0eede82b2671dd66a5417c7e1c8653b8c09\", \"media_blink_unittests\": \"458276a395183c8ad1be05e0c8fa93f9b14394ff\", \"media_unittests\": \"f05e2765b33dbe193c4e55efb5391d62f49fb604\", \"message_center_unittests\": \"d7ad8da7b96e9b8938cefa713a3c6d045e7ed0c1\", \"midi_unittests\": \"dab0b1ccfe5b85065c27d38555fb7e75352acd3d\", \"mojo_core_unittests\": \"3406d38dc4e359a1f573dd8b13b684c659cf2348\", \"mojo_unittests\": \"e6feed74142c41fbea99589845ab175452e34a5a\", \"nacl_helper_nonsfi_unittests\": \"66cb5a98a4c30875ec3e22118c472788989ba1c0\", \"nacl_loader_unittests\": \"8848eec90c71a9c70f62996a64a8955a13c2c889\", \"native_theme_unittests\": \"ef47cddf9401de3326f3af11516fb231a446a3f4\", \"net_unittests\": \"47f716b67dbb48bf6ddd412178b61a8359e7f5dc\", \"ozone_gl_unittests\": \"0bb0092976a43267aa82374bc7c4d1d4e81324fc\", \"ozone_unittests\": \"d7a43f8e83f4447e11070020a2ff7cc8916b1aa6\", \"ozone_x11_unittests\": \"f9863df7d6ccae17fef955b99895de3db278c429\", \"pdf_unittests\": \"148a0af0515180ce1d21ac25bf5b6a587ae592cf\", \"perfetto_unittests\": \"650ae8effb6795b98a4f3d8b73dc4e60efa21f83\", \"ppapi_unittests\": \"b64eb2b554a3209c8b4a21e2feabc40ba15afec4\", \"printing_unittests\": \"6b0ebc7b68847665c2911e0ee5a4ea858ab7e7fd\", \"remoting_unittests\": \"19e9b9a813cff51c4f23a4b2b4171278e2cb24a9\", \"sandbox_linux_unittests\": \"fea96530565e0495689ed51085234f0f4494f882\", \"service_manager_unittests\": \"f8b680c9320976df811c4bc44626524b93154985\", \"services_unittests\": \"315ff16f8ea9dfb261dc513521e4dfae932e2566\", \"shell_dialogs_unittests\": \"a8b70d8a6548f3836fd1761c7b840c281733f712\", \"skia_unittests\": \"c2ec6a33a7f7c4cad390c2583f32202342cdfba8\", \"snapshot_unittests\": \"869ae5a5128d8171fd6f691aa7ad7c6e2fa346d7\", \"sql_unittests\": \"7ff19f23e7da379c1e49c06030f603fe8169a7d3\", \"storage_unittests\": \"6869f87d0af2605ddab5e53e5ec70f65c0ec3f8b\", \"sync_integration_tests\": \"3607dc93d02f089f15a0685d47e0ad4c78e406c8\", \"traffic_annotation_auditor_unittests\": \"cf2898cbd3f186471bc7ae6d318847db1881bdea\", \"ui_base_unittests\": \"6321f5d9586c5e05bca9bb25aca2384c0b9ad5b4\", \"ui_chromeos_unittests\": \"abb9252c0abd1b68a01cc3d6d6eb1c0309e4f996\", \"ui_touch_selection_unittests\": \"083b952cffac8c1327ed38adf2cf17a2e9016a77\", \"unit_tests\": \"58a22e983de91456f05ce93278df6d20f91c2b36\", \"url_unittests\": \"ac74ef8e2bbb2e907ec44d67b2c5203cb61977a7\", \"usage_time_limit_unittests\": \"bc8678fde5f51ef189cc7dffad12397e2cb4445f\", \"views_unittests\": \"dd5776b203a50adce02edc86a4e6b9f9e53b47c5\", \"viz_unittests\": \"d10327e01e3b2530fd5dd82975f55f5b610cc87f\", \"wayland_client_perftests\": \"cfd87571e391fce58b935354178aaabd71c4f1f7\", \"wm_unittests\": \"299fee6d1190a42a4da4b03e486acbb200c20fa1\", \"wtf_unittests\": \"6249fa41e4798532b7772595d13b5f6b223ce02d\", \"zlib_unittests\": \"6ca90be974f4fe5e8a10d9ae601dea0e2dff5ec2\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1989594bdf03467d4cca251563547d36d290a477ee0cdac91b5f17239ddd8c8b_v2\", \"builder_304607b978b8f4bcd63bac0f543c3a69f6b4c7cf202dcd2d3c5b8d4a70be201e_v2\", \"builder_47c3ec4238d3b3d0448e41826f5b2c1435e77a4255b8c93aa27077a59a7a5a67_v2\", \"builder_a2d0deb167035deb42f2d46ec8df60bd17682f54960fd7d9f79bcb4fddee3411_v2\", \"builder_bea46eaeedb7de1bd52f00a0308b818fe481ae542888a2fa5825ab1ef5ba3493_v2\", \"builder_df0918bfe72974da8c562c0af785205b640d6f631f017829e032ab97ab701012_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-east1-d-8-61-durd\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603640978372659",
"status": "COMPLETED",
"status_changed_ts": "1603645872297350",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42244",
"builder:linux-chromeos-rel",
"buildset:commit/git/c2c354c3e10e196e279d60bd90c46aa222579737",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c2c354c3e10e196e279d60bd90c46aa222579737",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030885874114657776",
"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/8865455811833236640/+/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:4f792e9536054f10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603645872310766",
"url": "https://ci.chromium.org/b/8865455811833236640",
"utcnow_ts": "1603645873465550"
}
}
[17:11:13.474] Invocation finished in 1h46m3.805677467s with status SUCCEEDED