[22:00:04.197] New invocation is queued and will start shortly
[22:00:05.444] Starting the invocation (attempt 1)
[22:00:05.486] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:00:05.487] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:00:05.487] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018539841188004592",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0e6291b0fb79ea09f6470bc8d547b4e067d49974\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9018539841188004592",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/0e6291b0fb79ea09f6470bc8d547b4e067d49974",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0e6291b0fb79ea09f6470bc8d547b4e067d49974",
"gitiles_ref:refs/heads/master"
]
}
[22:00:06.541] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615413605607295",
"id": "8853109779045595680",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0e6291b0fb79ea09f6470bc8d547b4e067d49974\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615413606315273",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46060",
"builder:linux-chromeos-rel",
"buildset:commit/git/0e6291b0fb79ea09f6470bc8d547b4e067d49974",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0e6291b0fb79ea09f6470bc8d547b4e067d49974",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018539841188004592",
"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/8853109779045595680/+/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": "1615413606315454",
"url": "https://ci.chromium.org/b/8853109779045595680",
"utcnow_ts": "1615413606521235"
}
}
[22:00:06.541] Task URL: https://ci.chromium.org/b/8853109779045595680
[22:00:06.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:2:0) after 1m0s
[22:01:06.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:2:0)
[22:01:06.557] Timer tick, asking Buildbucket for the build status
[22:01:06.765] Build 8853109779045595680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:01:06.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:3:0) after 1m0s
[22:02:06.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:3:0)
[22:02:06.774] Timer tick, asking Buildbucket for the build status
[22:02:07.006] Build 8853109779045595680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:02:07.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:4:0) after 1m0s
[22:03:07.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:4:0)
[22:03:07.035] Timer tick, asking Buildbucket for the build status
[22:03:07.111] Build 8853109779045595680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:03:07.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:5:0) after 1m0s
[22:04:07.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:5:0)
[22:04:07.212] Timer tick, asking Buildbucket for the build status
[22:04:07.529] Build 8853109779045595680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:04:07.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:6:0) after 1m0s
[22:05:07.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:6:0)
[22:05:07.608] Timer tick, asking Buildbucket for the build status
[22:05:07.694] Build 8853109779045595680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:05:07.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:7:0) after 1m0s
[22:06:07.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:7:0)
[22:06:07.730] Timer tick, asking Buildbucket for the build status
[22:06:07.850] Build 8853109779045595680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:06:07.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:8:0) after 1m0s
[22:07:07.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:8:0)
[22:07:07.938] Timer tick, asking Buildbucket for the build status
[22:07:08.005] Build 8853109779045595680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:07:08.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:9:0) after 1m0s
[22:08:08.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:9:0)
[22:08:08.043] Timer tick, asking Buildbucket for the build status
[22:08:08.121] Build 8853109779045595680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:08:08.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:10:0) after 1m0s
[22:09:08.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:10:0)
[22:09:08.136] Timer tick, asking Buildbucket for the build status
[22:09:08.209] Build 8853109779045595680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:09:08.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:11:0) after 1m0s
[22:10:08.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:11:0)
[22:10:08.247] Timer tick, asking Buildbucket for the build status
[22:10:08.578] Build 8853109779045595680: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:10:08.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:12:0) after 1m0s
[22:10:16.488] Received PubSub notification, asking Buildbucket for the build status
[22:10:16.574] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:08.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:12:0)
[22:11:08.613] Timer tick, asking Buildbucket for the build status
[22:11:08.710] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:08.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:14:0) after 1m0s
[22:12:08.721] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:14:0)
[22:12:08.721] Timer tick, asking Buildbucket for the build status
[22:12:08.803] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:08.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:15:0) after 1m0s
[22:13:08.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:15:0)
[22:13:08.824] Timer tick, asking Buildbucket for the build status
[22:13:08.894] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:08.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:16:0) after 1m0s
[22:14:08.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:16:0)
[22:14:08.966] Timer tick, asking Buildbucket for the build status
[22:14:09.072] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:09.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:17:0) after 1m0s
[22:15:09.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:17:0)
[22:15:09.147] Timer tick, asking Buildbucket for the build status
[22:15:09.257] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:09.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:18:0) after 1m0s
[22:16:09.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:18:0)
[22:16:09.318] Timer tick, asking Buildbucket for the build status
[22:16:09.458] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:09.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:19:0) after 1m0s
[22:17:09.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:19:0)
[22:17:09.480] Timer tick, asking Buildbucket for the build status
[22:17:09.748] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:09.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:20:0) after 1m0s
[22:18:09.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:20:0)
[22:18:09.789] Timer tick, asking Buildbucket for the build status
[22:18:09.863] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:09.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:21:0) after 1m0s
[22:19:09.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:21:0)
[22:19:09.932] Timer tick, asking Buildbucket for the build status
[22:19:10.029] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:10.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:22:0) after 1m0s
[22:20:10.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:22:0)
[22:20:10.169] Timer tick, asking Buildbucket for the build status
[22:20:10.244] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:10.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:23:0) after 1m0s
[22:21:10.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:23:0)
[22:21:10.334] Timer tick, asking Buildbucket for the build status
[22:21:10.458] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:10.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:24:0) after 1m0s
[22:22:10.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:24:0)
[22:22:10.464] Timer tick, asking Buildbucket for the build status
[22:22:10.733] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:10.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:25:0) after 1m0s
[22:23:10.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:25:0)
[22:23:10.825] Timer tick, asking Buildbucket for the build status
[22:23:10.947] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:10.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:26:0) after 1m0s
[22:24:11.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:26:0)
[22:24:11.095] Timer tick, asking Buildbucket for the build status
[22:24:11.180] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:11.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:27:0) after 1m0s
[22:25:11.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:27:0)
[22:25:11.305] Timer tick, asking Buildbucket for the build status
[22:25:11.447] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:11.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:28:0) after 1m0s
[22:26:11.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:28:0)
[22:26:11.532] Timer tick, asking Buildbucket for the build status
[22:26:11.634] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:11.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:29:0) after 1m0s
[22:27:11.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:29:0)
[22:27:11.767] Timer tick, asking Buildbucket for the build status
[22:27:11.836] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:11.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:30:0) after 1m0s
[22:28:12.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:30:0)
[22:28:12.009] Timer tick, asking Buildbucket for the build status
[22:28:12.069] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:12.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:31:0) after 1m0s
[22:29:12.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:31:0)
[22:29:12.137] Timer tick, asking Buildbucket for the build status
[22:29:12.239] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:12.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:32:0) after 1m0s
[22:30:12.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:32:0)
[22:30:12.265] Timer tick, asking Buildbucket for the build status
[22:30:12.383] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:12.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:33:0) after 1m0s
[22:31:12.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:33:0)
[22:31:12.934] Timer tick, asking Buildbucket for the build status
[22:31:13.081] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:13.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:34:0) after 1m0s
[22:32:13.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:34:0)
[22:32:13.170] Timer tick, asking Buildbucket for the build status
[22:32:13.315] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:13.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:35:0) after 1m0s
[22:33:13.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:35:0)
[22:33:13.420] Timer tick, asking Buildbucket for the build status
[22:33:13.483] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:13.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:36:0) after 1m0s
[22:34:13.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:36:0)
[22:34:13.496] Timer tick, asking Buildbucket for the build status
[22:34:13.751] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:13.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:37:0) after 1m0s
[22:35:13.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:37:0)
[22:35:13.822] Timer tick, asking Buildbucket for the build status
[22:35:14.019] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:14.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:38:0) after 1m0s
[22:36:14.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:38:0)
[22:36:14.008] Timer tick, asking Buildbucket for the build status
[22:36:15.471] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:15.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:39:0) after 1m0s
[22:37:15.592] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:39:0)
[22:37:15.592] Timer tick, asking Buildbucket for the build status
[22:37:15.685] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:15.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:40:0) after 1m0s
[22:38:15.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:40:0)
[22:38:15.753] Timer tick, asking Buildbucket for the build status
[22:38:16.030] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:16.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:41:0) after 1m0s
[22:39:16.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:41:0)
[22:39:16.055] Timer tick, asking Buildbucket for the build status
[22:39:16.116] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:16.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:42:0) after 1m0s
[22:40:16.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:42:0)
[22:40:16.230] Timer tick, asking Buildbucket for the build status
[22:40:16.416] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:16.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:43:0) after 1m0s
[22:41:16.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:43:0)
[22:41:16.472] Timer tick, asking Buildbucket for the build status
[22:41:16.551] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:16.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:44:0) after 1m0s
[22:42:16.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:44:0)
[22:42:16.599] Timer tick, asking Buildbucket for the build status
[22:42:16.775] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:16.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:45:0) after 1m0s
[22:43:16.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:45:0)
[22:43:16.814] Timer tick, asking Buildbucket for the build status
[22:43:16.889] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:16.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:46:0) after 1m0s
[22:44:16.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:46:0)
[22:44:16.917] Timer tick, asking Buildbucket for the build status
[22:44:17.005] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:17.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:47:0) after 1m0s
[22:45:17.079] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:47:0)
[22:45:17.079] Timer tick, asking Buildbucket for the build status
[22:45:17.190] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:17.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:48:0) after 1m0s
[22:46:17.262] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:48:0)
[22:46:17.262] Timer tick, asking Buildbucket for the build status
[22:46:17.556] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:17.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:49:0) after 1m0s
[22:47:17.569] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:49:0)
[22:47:17.569] Timer tick, asking Buildbucket for the build status
[22:47:17.641] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:17.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:50:0) after 1m0s
[22:48:17.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:50:0)
[22:48:17.642] Timer tick, asking Buildbucket for the build status
[22:48:17.706] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:17.706] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:51:0) after 1m0s
[22:49:17.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:51:0)
[22:49:17.801] Timer tick, asking Buildbucket for the build status
[22:49:18.054] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:18.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:52:0) after 1m0s
[22:50:18.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:52:0)
[22:50:18.102] Timer tick, asking Buildbucket for the build status
[22:50:18.211] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:18.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:53:0) after 1m0s
[22:51:18.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:53:0)
[22:51:18.239] Timer tick, asking Buildbucket for the build status
[22:51:18.320] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:18.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:54:0) after 1m0s
[22:52:18.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:54:0)
[22:52:18.342] Timer tick, asking Buildbucket for the build status
[22:52:18.429] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:18.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:55:0) after 1m0s
[22:53:18.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:55:0)
[22:53:18.429] Timer tick, asking Buildbucket for the build status
[22:53:18.494] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:18.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:56:0) after 1m0s
[22:54:18.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:56:0)
[22:54:18.537] Timer tick, asking Buildbucket for the build status
[22:54:18.831] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:18.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:57:0) after 1m0s
[22:55:18.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:57:0)
[22:55:18.877] Timer tick, asking Buildbucket for the build status
[22:55:19.035] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:19.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:58:0) after 1m0s
[22:56:19.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:58:0)
[22:56:19.027] Timer tick, asking Buildbucket for the build status
[22:56:19.125] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:19.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:59:0) after 1m0s
[22:57:19.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:59:0)
[22:57:19.227] Timer tick, asking Buildbucket for the build status
[22:57:19.302] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:19.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:60:0) after 1m0s
[22:58:19.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:60:0)
[22:58:19.304] Timer tick, asking Buildbucket for the build status
[22:58:19.361] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:19.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:61:0) after 1m0s
[22:59:19.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:61:0)
[22:59:19.412] Timer tick, asking Buildbucket for the build status
[22:59:19.498] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:19.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:62:0) after 1m0s
[23:00:19.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:62:0)
[23:00:19.522] Timer tick, asking Buildbucket for the build status
[23:00:19.874] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:19.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:63:0) after 1m0s
[23:01:19.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:63:0)
[23:01:19.899] Timer tick, asking Buildbucket for the build status
[23:01:20.074] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:20.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:64:0) after 1m0s
[23:02:20.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:64:0)
[23:02:20.113] Timer tick, asking Buildbucket for the build status
[23:02:20.541] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:20.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:65:0) after 1m0s
[23:03:20.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:65:0)
[23:03:20.583] Timer tick, asking Buildbucket for the build status
[23:03:20.744] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:20.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:66:0) after 1m0s
[23:04:20.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:66:0)
[23:04:20.798] Timer tick, asking Buildbucket for the build status
[23:04:20.923] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:20.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:67:0) after 1m0s
[23:05:20.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:67:0)
[23:05:20.973] Timer tick, asking Buildbucket for the build status
[23:05:21.081] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:21.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:68:0) after 1m0s
[23:06:21.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:68:0)
[23:06:21.166] Timer tick, asking Buildbucket for the build status
[23:06:21.253] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:21.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:69:0) after 1m0s
[23:07:21.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:69:0)
[23:07:21.275] Timer tick, asking Buildbucket for the build status
[23:07:21.367] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:21.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:70:0) after 1m0s
[23:08:21.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:70:0)
[23:08:21.398] Timer tick, asking Buildbucket for the build status
[23:08:21.480] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:21.480] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:71:0) after 1m0s
[23:09:21.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:71:0)
[23:09:21.513] Timer tick, asking Buildbucket for the build status
[23:09:21.594] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:21.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:72:0) after 1m0s
[23:10:21.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:72:0)
[23:10:21.608] Timer tick, asking Buildbucket for the build status
[23:10:22.326] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:22.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:73:0) after 1m0s
[23:11:22.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:73:0)
[23:11:22.426] Timer tick, asking Buildbucket for the build status
[23:11:22.495] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:22.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:74:0) after 1m0s
[23:12:22.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:74:0)
[23:12:22.504] Timer tick, asking Buildbucket for the build status
[23:12:22.579] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:22.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:75:0) after 1m0s
[23:13:22.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:75:0)
[23:13:22.606] Timer tick, asking Buildbucket for the build status
[23:13:22.699] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:22.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:76:0) after 1m0s
[23:14:22.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:76:0)
[23:14:22.750] Timer tick, asking Buildbucket for the build status
[23:14:29.618] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:29.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:77:0) after 1m0s
[23:15:29.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:77:0)
[23:15:29.743] Timer tick, asking Buildbucket for the build status
[23:15:29.842] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:29.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:78:0) after 1m0s
[23:16:30.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:78:0)
[23:16:30.011] Timer tick, asking Buildbucket for the build status
[23:16:30.508] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:30.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:79:0) after 1m0s
[23:17:30.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:79:0)
[23:17:30.627] Timer tick, asking Buildbucket for the build status
[23:17:30.944] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:30.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:80:0) after 1m0s
[23:18:30.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:80:0)
[23:18:30.985] Timer tick, asking Buildbucket for the build status
[23:18:31.056] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:31.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:81:0) after 1m0s
[23:19:31.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:81:0)
[23:19:31.137] Timer tick, asking Buildbucket for the build status
[23:19:31.202] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:31.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:82:0) after 1m0s
[23:20:31.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:82:0)
[23:20:31.234] Timer tick, asking Buildbucket for the build status
[23:20:31.319] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:31.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:83:0) after 1m0s
[23:21:31.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:83:0)
[23:21:31.402] Timer tick, asking Buildbucket for the build status
[23:21:31.535] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:31.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:84:0) after 1m0s
[23:22:31.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:84:0)
[23:22:31.606] Timer tick, asking Buildbucket for the build status
[23:22:31.822] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:31.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:85:0) after 1m0s
[23:23:31.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:85:0)
[23:23:31.879] Timer tick, asking Buildbucket for the build status
[23:23:32.045] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:32.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:86:0) after 1m0s
[23:24:32.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:86:0)
[23:24:32.088] Timer tick, asking Buildbucket for the build status
[23:24:32.171] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:32.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:87:0) after 1m0s
[23:25:32.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:87:0)
[23:25:32.239] Timer tick, asking Buildbucket for the build status
[23:25:32.321] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:32.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:88:0) after 1m0s
[23:26:32.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:88:0)
[23:26:32.363] Timer tick, asking Buildbucket for the build status
[23:26:32.441] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:32.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:89:0) after 1m0s
[23:27:32.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:89:0)
[23:27:32.436] Timer tick, asking Buildbucket for the build status
[23:27:32.507] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:32.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:90:0) after 1m0s
[23:28:32.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:90:0)
[23:28:32.552] Timer tick, asking Buildbucket for the build status
[23:28:32.621] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:32.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:91:0) after 1m0s
[23:29:32.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:91:0)
[23:29:32.740] Timer tick, asking Buildbucket for the build status
[23:29:33.177] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:33.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:92:0) after 1m0s
[23:30:33.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:92:0)
[23:30:33.245] Timer tick, asking Buildbucket for the build status
[23:30:33.347] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:33.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:93:0) after 1m0s
[23:31:33.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:93:0)
[23:31:33.431] Timer tick, asking Buildbucket for the build status
[23:31:33.561] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:33.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:94:0) after 1m0s
[23:32:33.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:94:0)
[23:32:33.629] Timer tick, asking Buildbucket for the build status
[23:32:33.886] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:33.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:95:0) after 1m0s
[23:33:33.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:95:0)
[23:33:33.988] Timer tick, asking Buildbucket for the build status
[23:33:34.072] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:34.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:96:0) after 1m0s
[23:34:34.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:96:0)
[23:34:34.325] Timer tick, asking Buildbucket for the build status
[23:34:34.394] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:34.394] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:97:0) after 1m0s
[23:35:34.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:97:0)
[23:35:34.555] Timer tick, asking Buildbucket for the build status
[23:35:34.883] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:34.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:98:0) after 1m0s
[23:36:35.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:98:0)
[23:36:35.166] Timer tick, asking Buildbucket for the build status
[23:36:35.245] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:35.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:99:0) after 1m0s
[23:37:35.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:99:0)
[23:37:35.394] Timer tick, asking Buildbucket for the build status
[23:37:35.478] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:35.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:100:0) after 1m0s
[23:38:35.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:100:0)
[23:38:35.503] Timer tick, asking Buildbucket for the build status
[23:38:35.566] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:35.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:101:0) after 1m0s
[23:39:35.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:101:0)
[23:39:35.638] Timer tick, asking Buildbucket for the build status
[23:39:35.833] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:35.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:102:0) after 1m0s
[23:40:35.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:102:0)
[23:40:35.856] Timer tick, asking Buildbucket for the build status
[23:40:35.947] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:35.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:103:0) after 1m0s
[23:41:36.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:103:0)
[23:41:36.101] Timer tick, asking Buildbucket for the build status
[23:41:36.255] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:36.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:104:0) after 1m0s
[23:42:36.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:104:0)
[23:42:36.267] Timer tick, asking Buildbucket for the build status
[23:42:36.367] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:36.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:105:0) after 1m0s
[23:43:36.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:105:0)
[23:43:36.412] Timer tick, asking Buildbucket for the build status
[23:43:36.713] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:36.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:106:0) after 1m0s
[23:44:36.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:106:0)
[23:44:36.756] Timer tick, asking Buildbucket for the build status
[23:44:36.860] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:36.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:107:0) after 1m0s
[23:45:36.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:107:0)
[23:45:36.866] Timer tick, asking Buildbucket for the build status
[23:45:37.026] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:37.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:108:0) after 1m0s
[23:46:37.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:108:0)
[23:46:37.094] Timer tick, asking Buildbucket for the build status
[23:46:37.164] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:37.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:109:0) after 1m0s
[23:47:37.249] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:109:0)
[23:47:37.249] Timer tick, asking Buildbucket for the build status
[23:47:37.434] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:37.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:110:0) after 1m0s
[23:48:37.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:110:0)
[23:48:37.422] Timer tick, asking Buildbucket for the build status
[23:48:37.536] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:37.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:111:0) after 1m0s
[23:49:37.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:111:0)
[23:49:37.624] Timer tick, asking Buildbucket for the build status
[23:49:37.692] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:37.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:112:0) after 1m0s
[23:50:37.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:112:0)
[23:50:37.830] Timer tick, asking Buildbucket for the build status
[23:50:37.907] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:37.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:113:0) after 1m0s
[23:51:38.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:113:0)
[23:51:38.025] Timer tick, asking Buildbucket for the build status
[23:51:38.111] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:38.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:114:0) after 1m0s
[23:52:38.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:114:0)
[23:52:38.168] Timer tick, asking Buildbucket for the build status
[23:52:38.241] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:38.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:115:0) after 1m0s
[23:53:38.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:115:0)
[23:53:38.354] Timer tick, asking Buildbucket for the build status
[23:53:38.518] Build 8853109779045595680: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:38.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018539841188004592:116:0) after 1m0s
[23:54:08.241] Received PubSub notification, asking Buildbucket for the build status
[23:54:08.622] Build 8853109779045595680: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:54:08.622] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615420446206480",
"created_by": "project:chromium",
"created_ts": "1615413605607295",
"id": "8853109779045595680",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0e6291b0fb79ea09f6470bc8d547b4e067d49974\"}}",
"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\": \"0e6291b0fb79ea09f6470bc8d547b4e067d49974\", \"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-99-01s3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 46060, \"got_angle_revision\": \"331640e5c19e63209de0307ae37dc1ec69a1f4e0\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"0e6291b0fb79ea09f6470bc8d547b4e067d49974\", \"got_revision_cp\": \"refs/heads/master@{#861720}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"f6b9f78f5d13401dd4ba1dfdacb65056c89715b5\", \"got_v8_revision_cp\": \"refs/heads/9.1.93@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"is_cached\": false, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-inverse-fieldtrials-fyi-rel\", \"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0e6291b0fb79ea09f6470bc8d547b4e067d49974\", \"swarm_hashes_refs/heads/master(at){#861720}_without_patch\": {\"absl_hardening_tests\": \"26d4a3e72f6056a7da13dceca5a9505f6646f862\", \"accessibility_unittests\": \"ca19a137cdce0ab380d3d8e551feb2bea917583f\", \"angle_unittests\": \"a01e944e3ef7ed7faa39150c5046694703d3475e\", \"app_list_unittests\": \"f2f12c8894d75dcf3a277ace54ca809f2b93c5cc\", \"app_shell_unittests\": \"0a97f68b7ed837a240a99610b6bb59c8030df84a\", \"ash_unittests\": \"486498d34d90034013dad43f69cabe5de662d258\", \"aura_unittests\": \"0e80352feab1d8ebec60a827b6cd5d683774d074\", \"base_unittests\": \"7f8e0a5f4fe89cbb6d429dec4e93e8f99f1213d9\", \"base_util_unittests\": \"f2d4e3c72f526aa59103ead29d7a1b6e6fcc2cbf\", \"blink_common_unittests\": \"17824bbd70c12cf45029b73064d855deed5c4c39\", \"blink_fuzzer_unittests\": \"8fea146656f917e9cc8aa90a95510fadd55b30d5\", \"blink_heap_unittests\": \"7f9821c2e828a9db847c20234c0a15458f38b792\", \"blink_platform_unittests\": \"4a208971b783d26a4cb28ee6f285cf85057fdf03\", \"blink_unittests\": \"d6ad558e5601fb506f51ec437a9570f8852d6feb\", \"boringssl_crypto_tests\": \"ec94b595788dc848eadade229d43687c585e341a\", \"boringssl_ssl_tests\": \"38d7b84743a47c60fc744c4c17aa3d5277cc2a3b\", \"browser_tests\": \"aa7621752822bf36ba5480bad1a21408dd4d297a\", \"capture_unittests\": \"26af18b2d661d7d9ceaa1097107a27efa0a2238e\", \"cast_unittests\": \"09882ce2204e95ae8ae4f8c4d2e45549c1281f37\", \"cc_unittests\": \"e5278b2c7efe59451231057b47de4f1ebbe6c592\", \"chrome_app_unittests\": \"f4b60a023ae38de8dcf46e65aab4cb5e62258f4e\", \"chromedriver_unittests\": \"afc01c212fee7f0b2d2a667e39c6d113981944d4\", \"chromeos_components_unittests\": \"d9173c556c08391a291b0edd67f52d8bf708d656\", \"chromeos_unittests\": \"77b948824621688446d39cf4acead4204eefc669\", \"color_unittests\": \"b5cf6b809f3e75477ad72d596ab55abd6bdf905d\", \"components_browsertests\": \"ed83ef47ccce23fe76ca25c38747107aa2f0a308\", \"components_unittests\": \"1ad5a2530afb0e5573d2f001bd7dc16ac3bf08c6\", \"compositor_unittests\": \"4f417b4c533cd297facc067b072f4f9f02df1e51\", \"content_browsertests\": \"42aae6ed349ff957c9bd520e0c1b4be1e046f4c8\", \"content_unittests\": \"3834820b167ca7347c05d6271bde406f632c70b6\", \"crashpad_tests\": \"f6787d0a94e48a22243e98ab8a9317eb150387d8\", \"crypto_unittests\": \"8255fabb482ff8d7598091a23504050bb50c4009\", \"dbus_unittests\": \"efedcd9869151762d3062f9706fb4848fdbe1a7a\", \"device_unittests\": \"27b11ef8f19a2a174e35b26b203e66c7b7028166\", \"display_unittests\": \"9526eec664c709ecd5d4d19253b98d8fd642b903\", \"events_unittests\": \"41da1aae0b85b15316b5677e922934a6e448ce39\", \"exo_unittests\": \"f040f5346af2fb6a53a0e62be3b4e64a5abfb644\", \"extensions_browsertests\": \"e6f1786002174f8decb3b6d27167d22754505c0d\", \"extensions_unittests\": \"3271e59acf18c4b770b48e39383a76e3e289ea23\", \"filesystem_service_unittests\": \"5295553fd81d44fa5eb524d639cf1eec06e57523\", \"gcm_unit_tests\": \"f56299cbc1974e5a0af20da05620335285f8fb33\", \"gfx_unittests\": \"8a40c8bba05b225cd7716ab1ef57cc9ffc6e47e9\", \"gin_unittests\": \"7af74811dc545e567becc00f3a7666d1b0017307\", \"gl_unittests_ozone\": \"0b1805021ec266072363ee7c1cc58f890349e120\", \"google_apis_unittests\": \"5f0bdf65574f40a61c86765d0ac7aff8cdcedce4\", \"gpu_unittests\": \"e043f18c2b29d07d956786113940bff20b93130e\", \"gwp_asan_unittests\": \"1d8fa2e4ede02ec03f104e7adf24f91c227fdb84\", \"interactive_ui_tests\": \"3879e0327d6693bae6643aa17381797e07553ffc\", \"ipc_tests\": \"7d1dc833a66ee0934beb2c7dec2cf2f47691dcdc\", \"jingle_unittests\": \"5655b0168494224be31f5bccb24a70cbe72827ba\", \"keyboard_unittests\": \"e839117e61c1feb51054c1f8603fe8a565645eee\", \"latency_unittests\": \"14d6368d52af19880b74da2fabf72f3b41a8976f\", \"libjingle_xmpp_unittests\": \"3360b7ac80d112077e3a9f075bc0dad14cc5bfe8\", \"liburlpattern_unittests\": \"f28e850bed08ceaad21bf457db1b5b9e3b26d130\", \"media_blink_unittests\": \"9fc01c25ae1dfeccb6677122b2ccc2a96889b166\", \"media_unittests\": \"7a239ceef3a6ab1ed9bf2e5e03d637b783ea6b29\", \"message_center_unittests\": \"2d26fcfa137296167f66f6745025dfac60186bbd\", \"midi_unittests\": \"dfbbdb0a5767668e4acc7ea29d434c8a74d74fd3\", \"mojo_core_unittests\": \"6158c76d5a82eac99d234cef2f12e1c9864c25e4\", \"mojo_unittests\": \"6cac9d2163744f7da7c92b58d69865f2e2f8aaca\", \"nacl_helper_nonsfi_unittests\": \"da72dda8b11fb04d4fb71711d1b312c28f5ec823\", \"nacl_loader_unittests\": \"e8368e3afd373c901f00dfe9f43a22e41863fd4e\", \"native_theme_unittests\": \"22e9a2da6e8b94e863915ae35be0fb3a89183fde\", \"net_unittests\": \"aecd4ab88974b105ed26f0bd33a852650157a3dc\", \"ozone_gl_unittests\": \"b07807e2cc53336aaba0033ecb4d626ac70483cc\", \"ozone_unittests\": \"2738c008eae51c10e32eef4f4d0c643b35e9dfdc\", \"ozone_x11_unittests\": \"f085e05c343dd7db17015028ed9b708cfa24372a\", \"pdf_unittests\": \"cf8dd601952bf02a684717e99c5a8dedf1861b07\", \"perfetto_unittests\": \"9537e2f89819a69176968af27794def243925fe7\", \"ppapi_unittests\": \"7decf77eed8633a9ad9527bea081f57ac5ab5287\", \"printing_unittests\": \"9dc17c319bb33f6f9e78a452310c0da17f06d7df\", \"remoting_unittests\": \"d4a1aa5cfb9dc3fbadef91fdb3bd00051aa3249b\", \"sandbox_linux_unittests\": \"b17db66a3e34787b62355f82bd3796a95cdd0129\", \"service_manager_unittests\": \"458290dc4d3a0adae7e9c3be11af43354df4c04a\", \"services_unittests\": \"b2bdb357ff8245c27906492365f1cd86dafa08ef\", \"shell_dialogs_unittests\": \"56c2a4abffafea18ad2ec397aad291cc520795ae\", \"shell_encryption_unittests\": \"ff32f8f1c027c9383d3fee2bdda518869a3e0d1e\", \"skia_unittests\": \"d6ca5e19c61abd95a37113ad73ec8a5eb39d2b74\", \"snapshot_unittests\": \"e3bc71587573e9d446ef4886733fa50a55a09169\", \"sql_unittests\": \"c8e30252055ab69c5d588926a25a42a3d638ebd4\", \"storage_unittests\": \"30ac51f55e38553e331d6b48fc7fa2012b5a3399\", \"sync_integration_tests\": \"68c52361054b0023f4fb0fbb17243d73a1510552\", \"traffic_annotation_auditor_unittests\": \"52280fdd172844a11c2cb778d621a247e6896f19\", \"ui_base_unittests\": \"0f73ff50186eb6109ad6b384b7689d52a5c89451\", \"ui_chromeos_unittests\": \"5ccf04b02d5339c145ec4d4c43588e986cea2601\", \"ui_touch_selection_unittests\": \"2582d53d7bb42906fb9db15c0eb32357c7a0ab04\", \"unit_tests\": \"9f1a2ceb77d2b4f2c0758d417df35832343cbc4c\", \"url_unittests\": \"e4590dfdc2f0b640d31f3bbf88dabf6e54daecea\", \"usage_time_limit_unittests\": \"967dc559ce20880973ac2fedd74ae676d0527a1c\", \"views_unittests\": \"5b84bb7ceea04f2452917929a971e3fb8b4ca250\", \"viz_unittests\": \"9251c93e717b85e7a81adf29815278369801a643\", \"wayland_client_perftests\": \"2a2a2f20fc3ee859aefb4bcb763458afe7b4b575\", \"wayland_client_tests\": \"7f3746e7e807ccdcf31d4bc3860f5fe9dfe518c3\", \"wm_unittests\": \"a458093a62209e98dde50bfa7f09b568c256c4d5\", \"wtf_unittests\": \"fc87d3c62086c28063a59fd3572e5d2c89340253\", \"zlib_unittests\": \"c358b3156746c08903958aa95faa39842e842634\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_000e1c4f189e74dd1a526f6a0536d3e0149cd531063dba85a70e270d680dde3a_v2\", \"builder_0b12ebe7b5a85484d05a2e374fff062d76e5173f31df9c66ec374db61ba113e3_v2\", \"builder_71ab4550ecc1db180544ee9bd5ebac58222d39ccc6e59d756fcde46903b3067c_v2\", \"builder_9b311965bcdd39b39aa4e18428ed38a374d2d5d9f2ab24593845b266390676f3_v2\", \"builder_a429a0546f8e6c4723d24c56a52324080ff34901f86bcb95ca025de078e0f0c5_v2\", \"builder_a6d905fb3e765cf980c6458181cc20495ddb667b30aa758edddbed3b46166dd6_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_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-99-01s3\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5746-91ff3bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615414216023696",
"status": "COMPLETED",
"status_changed_ts": "1615420446539972",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46060",
"builder:linux-chromeos-rel",
"buildset:commit/git/0e6291b0fb79ea09f6470bc8d547b4e067d49974",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0e6291b0fb79ea09f6470bc8d547b4e067d49974",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018539841188004592",
"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/8853109779045595680/+/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:5236f9178dfa5610",
"user_agent:luci-scheduler"
],
"updated_ts": "1615420446607091",
"url": "https://ci.chromium.org/b/8853109779045595680",
"utcnow_ts": "1615420448607770"
}
}
[23:54:08.622] Invocation finished in 1h54m4.442366319s with status SUCCEEDED