[10:23:02.565] New invocation is queued and will start shortly
[10:23:04.201] Starting the invocation (attempt 1)
[10:23:04.245] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:23:04.245] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:23:04.245] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030904881789842384",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9be30fc3958f86f2a3151bd5b30b96ea4c444c65\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9030904881789842384",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/9be30fc3958f86f2a3151bd5b30b96ea4c444c65",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9be30fc3958f86f2a3151bd5b30b96ea4c444c65",
"gitiles_ref:refs/heads/master"
]
}
[10:23:05.049] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603621384362181",
"id": "8865474819229719984",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9be30fc3958f86f2a3151bd5b30b96ea4c444c65\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603621384865572",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42241",
"builder:linux-chromeos-rel",
"buildset:commit/git/9be30fc3958f86f2a3151bd5b30b96ea4c444c65",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9be30fc3958f86f2a3151bd5b30b96ea4c444c65",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030904881789842384",
"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/8865474819229719984/+/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": "1603621384865680",
"url": "https://ci.chromium.org/b/8865474819229719984",
"utcnow_ts": "1603621385042260"
}
}
[10:23:05.049] Task URL: https://ci.chromium.org/b/8865474819229719984
[10:23:05.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:2:0) after 1m0s
[10:24:05.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:2:0)
[10:24:05.138] Timer tick, asking Buildbucket for the build status
[10:24:05.235] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:24:05.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:3:0) after 1m0s
[10:25:05.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:3:0)
[10:25:05.706] Timer tick, asking Buildbucket for the build status
[10:25:05.993] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:25:05.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:4:0) after 1m0s
[10:26:06.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:4:0)
[10:26:06.087] Timer tick, asking Buildbucket for the build status
[10:26:06.245] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:26:06.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:5:0) after 1m0s
[10:27:06.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:5:0)
[10:27:06.229] Timer tick, asking Buildbucket for the build status
[10:27:06.490] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:27:06.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:6:0) after 1m0s
[10:28:06.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:6:0)
[10:28:06.516] Timer tick, asking Buildbucket for the build status
[10:28:06.683] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:28:06.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:7:0) after 1m0s
[10:29:20.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:7:0)
[10:29:20.601] Timer tick, asking Buildbucket for the build status
[10:29:20.686] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:29:20.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:8:0) after 1m0s
[10:30:20.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:8:0)
[10:30:20.766] Timer tick, asking Buildbucket for the build status
[10:30:20.842] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:30:20.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:9:0) after 1m0s
[10:31:20.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:9:0)
[10:31:20.863] Timer tick, asking Buildbucket for the build status
[10:31:20.936] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:31:20.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:10:0) after 1m0s
[10:32:20.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:10:0)
[10:32:20.954] Timer tick, asking Buildbucket for the build status
[10:32:21.053] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:32:21.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:11:0) after 1m0s
[10:33:21.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:11:0)
[10:33:21.036] Timer tick, asking Buildbucket for the build status
[10:33:21.147] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:33:21.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:12:0) after 1m0s
[10:34:21.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:12:0)
[10:34:21.205] Timer tick, asking Buildbucket for the build status
[10:34:21.287] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:34:21.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:13:0) after 1m0s
[10:35:21.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:13:0)
[10:35:21.362] Timer tick, asking Buildbucket for the build status
[10:35:21.444] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:35:21.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:14:0) after 1m0s
[10:36:21.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:14:0)
[10:36:21.514] Timer tick, asking Buildbucket for the build status
[10:36:21.579] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:36:21.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:15:0) after 1m0s
[10:37:21.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:15:0)
[10:37:21.600] Timer tick, asking Buildbucket for the build status
[10:37:21.837] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:37:21.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:16:0) after 1m0s
[10:38:21.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:16:0)
[10:38:21.866] Timer tick, asking Buildbucket for the build status
[10:38:21.983] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:38:21.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:17:0) after 1m0s
[10:39:22.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:17:0)
[10:39:22.001] Timer tick, asking Buildbucket for the build status
[10:39:22.082] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:39:22.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:18:0) after 1m0s
[10:40:22.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:18:0)
[10:40:22.106] Timer tick, asking Buildbucket for the build status
[10:40:22.304] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:40:22.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:19:0) after 1m0s
[10:41:22.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:19:0)
[10:41:22.392] Timer tick, asking Buildbucket for the build status
[10:41:22.468] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:41:22.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:20:0) after 1m0s
[10:42:22.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:20:0)
[10:42:22.489] Timer tick, asking Buildbucket for the build status
[10:42:22.799] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:42:22.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:21:0) after 1m0s
[10:43:22.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:21:0)
[10:43:22.889] Timer tick, asking Buildbucket for the build status
[10:43:23.215] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:43:23.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:22:0) after 1m0s
[10:44:23.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:22:0)
[10:44:23.236] Timer tick, asking Buildbucket for the build status
[10:44:23.319] Build 8865474819229719984: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:44:23.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:23:0) after 1m0s
[10:45:23.122] Received PubSub notification, asking Buildbucket for the build status
[10:45:23.197] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:23.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:23:0)
[10:45:23.340] Timer tick, asking Buildbucket for the build status
[10:45:23.409] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:23.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:25:0) after 1m0s
[10:46:23.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:25:0)
[10:46:23.434] Timer tick, asking Buildbucket for the build status
[10:46:23.566] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:23.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:26:0) after 1m0s
[10:47:23.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:26:0)
[10:47:23.589] Timer tick, asking Buildbucket for the build status
[10:47:23.658] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:23.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:27:0) after 1m0s
[10:48:23.678] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:27:0)
[10:48:23.678] Timer tick, asking Buildbucket for the build status
[10:48:23.846] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:23.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:28:0) after 1m0s
[10:49:23.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:28:0)
[10:49:23.873] Timer tick, asking Buildbucket for the build status
[10:49:24.015] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:24.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:29:0) after 1m0s
[10:50:24.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:29:0)
[10:50:24.067] Timer tick, asking Buildbucket for the build status
[10:50:24.380] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:24.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:30:0) after 1m0s
[10:51:24.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:30:0)
[10:51:24.403] Timer tick, asking Buildbucket for the build status
[10:51:24.523] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:24.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:31:0) after 1m0s
[10:52:24.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:31:0)
[10:52:24.607] Timer tick, asking Buildbucket for the build status
[10:52:24.718] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:24.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:32:0) after 1m0s
[10:53:24.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:32:0)
[10:53:24.738] Timer tick, asking Buildbucket for the build status
[10:53:24.849] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:24.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:33:0) after 1m0s
[10:54:24.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:33:0)
[10:54:24.918] Timer tick, asking Buildbucket for the build status
[10:54:24.994] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:24.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:34:0) after 1m0s
[10:55:24.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:34:0)
[10:55:24.978] Timer tick, asking Buildbucket for the build status
[10:55:25.054] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:25.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:35:0) after 1m0s
[10:56:25.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:35:0)
[10:56:25.113] Timer tick, asking Buildbucket for the build status
[10:56:25.501] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:25.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:36:0) after 1m0s
[10:57:25.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:36:0)
[10:57:25.522] Timer tick, asking Buildbucket for the build status
[10:57:25.634] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:25.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:37:0) after 1m0s
[10:58:25.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:37:0)
[10:58:25.661] Timer tick, asking Buildbucket for the build status
[10:58:25.939] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:25.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:38:0) after 1m0s
[10:59:26.006] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:38:0)
[10:59:26.006] Timer tick, asking Buildbucket for the build status
[10:59:26.080] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:26.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:39:0) after 1m0s
[11:00:26.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:39:0)
[11:00:26.134] Timer tick, asking Buildbucket for the build status
[11:00:26.202] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:26.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:40:0) after 1m0s
[11:01:26.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:40:0)
[11:01:26.270] Timer tick, asking Buildbucket for the build status
[11:01:26.332] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:26.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:41:0) after 1m0s
[11:02:26.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:41:0)
[11:02:26.386] Timer tick, asking Buildbucket for the build status
[11:02:26.506] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:26.506] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:42:0) after 1m0s
[11:03:26.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:42:0)
[11:03:26.531] Timer tick, asking Buildbucket for the build status
[11:03:26.777] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:26.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:43:0) after 1m0s
[11:04:26.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:43:0)
[11:04:26.813] Timer tick, asking Buildbucket for the build status
[11:04:26.874] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:26.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:44:0) after 1m0s
[11:05:26.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:44:0)
[11:05:26.920] Timer tick, asking Buildbucket for the build status
[11:05:27.139] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:27.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:45:0) after 1m0s
[11:06:27.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:45:0)
[11:06:27.163] Timer tick, asking Buildbucket for the build status
[11:06:27.306] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:27.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:46:0) after 1m0s
[11:07:27.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:46:0)
[11:07:27.331] Timer tick, asking Buildbucket for the build status
[11:07:27.601] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:27.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:47:0) after 1m0s
[11:08:27.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:47:0)
[11:08:27.621] Timer tick, asking Buildbucket for the build status
[11:08:27.733] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:27.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:48:0) after 1m0s
[11:09:27.787] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:48:0)
[11:09:27.788] Timer tick, asking Buildbucket for the build status
[11:09:27.856] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:27.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:49:0) after 1m0s
[11:10:27.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:49:0)
[11:10:27.878] Timer tick, asking Buildbucket for the build status
[11:10:28.070] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:28.070] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:50:0) after 1m0s
[11:11:28.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:50:0)
[11:11:28.094] Timer tick, asking Buildbucket for the build status
[11:11:28.176] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:28.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:51:0) after 1m0s
[11:12:28.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:51:0)
[11:12:28.201] Timer tick, asking Buildbucket for the build status
[11:12:28.265] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:28.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:52:0) after 1m0s
[11:13:28.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:52:0)
[11:13:28.303] Timer tick, asking Buildbucket for the build status
[11:13:28.486] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:28.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:53:0) after 1m0s
[11:14:28.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:53:0)
[11:14:28.510] Timer tick, asking Buildbucket for the build status
[11:14:28.576] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:28.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:54:0) after 1m0s
[11:15:28.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:54:0)
[11:15:28.607] Timer tick, asking Buildbucket for the build status
[11:15:28.857] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:28.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:55:0) after 1m0s
[11:16:28.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:55:0)
[11:16:28.895] Timer tick, asking Buildbucket for the build status
[11:16:29.013] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:29.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:56:0) after 1m0s
[11:17:29.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:56:0)
[11:17:29.036] Timer tick, asking Buildbucket for the build status
[11:17:29.099] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:29.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:57:0) after 1m0s
[11:18:29.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:57:0)
[11:18:29.129] Timer tick, asking Buildbucket for the build status
[11:18:29.228] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:29.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:58:0) after 1m0s
[11:19:29.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:58:0)
[11:19:29.251] Timer tick, asking Buildbucket for the build status
[11:19:29.482] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:29.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:59:0) after 1m0s
[11:20:29.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:59:0)
[11:20:29.513] Timer tick, asking Buildbucket for the build status
[11:20:29.652] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:29.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:60:0) after 1m0s
[11:21:29.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:60:0)
[11:21:29.675] Timer tick, asking Buildbucket for the build status
[11:21:29.753] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:29.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:61:0) after 1m0s
[11:22:29.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:61:0)
[11:22:29.833] Timer tick, asking Buildbucket for the build status
[11:22:30.082] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:30.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:62:0) after 1m0s
[11:23:30.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:62:0)
[11:23:30.105] Timer tick, asking Buildbucket for the build status
[11:23:30.232] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:30.232] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:63:0) after 1m0s
[11:24:30.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:63:0)
[11:24:30.265] Timer tick, asking Buildbucket for the build status
[11:24:30.355] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:30.355] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:64:0) after 1m0s
[11:25:30.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:64:0)
[11:25:30.429] Timer tick, asking Buildbucket for the build status
[11:25:30.488] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:30.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:65:0) after 1m0s
[11:26:30.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:65:0)
[11:26:30.571] Timer tick, asking Buildbucket for the build status
[11:26:30.788] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:30.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:66:0) after 1m0s
[11:27:30.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:66:0)
[11:27:30.813] Timer tick, asking Buildbucket for the build status
[11:27:30.957] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:30.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:67:0) after 1m0s
[11:28:30.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:67:0)
[11:28:30.977] Timer tick, asking Buildbucket for the build status
[11:28:31.095] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:31.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:68:0) after 1m0s
[11:29:31.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:68:0)
[11:29:31.164] Timer tick, asking Buildbucket for the build status
[11:29:31.596] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:31.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:69:0) after 1m0s
[11:30:31.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:69:0)
[11:30:31.616] Timer tick, asking Buildbucket for the build status
[11:30:31.686] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:31.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:70:0) after 1m0s
[11:31:31.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:70:0)
[11:31:31.715] Timer tick, asking Buildbucket for the build status
[11:31:31.876] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:31.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:71:0) after 1m0s
[11:32:31.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:71:0)
[11:32:31.902] Timer tick, asking Buildbucket for the build status
[11:32:31.970] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:31.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:72:0) after 1m0s
[11:33:32.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:72:0)
[11:33:32.077] Timer tick, asking Buildbucket for the build status
[11:33:32.294] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:32.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:73:0) after 1m0s
[11:34:32.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:73:0)
[11:34:32.317] Timer tick, asking Buildbucket for the build status
[11:34:32.407] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:32.407] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:74:0) after 1m0s
[11:35:32.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:74:0)
[11:35:32.445] Timer tick, asking Buildbucket for the build status
[11:35:32.513] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:32.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:75:0) after 1m0s
[11:36:32.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:75:0)
[11:36:32.539] Timer tick, asking Buildbucket for the build status
[11:36:32.601] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:32.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:76:0) after 1m0s
[11:37:32.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:76:0)
[11:37:32.665] Timer tick, asking Buildbucket for the build status
[11:37:32.745] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:32.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:77:0) after 1m0s
[11:38:32.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:77:0)
[11:38:32.727] Timer tick, asking Buildbucket for the build status
[11:38:32.832] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:32.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:78:0) after 1m0s
[11:39:32.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:78:0)
[11:39:32.866] Timer tick, asking Buildbucket for the build status
[11:39:33.186] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:33.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:79:0) after 1m0s
[11:40:33.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:79:0)
[11:40:33.211] Timer tick, asking Buildbucket for the build status
[11:40:33.276] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:33.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:80:0) after 1m0s
[11:41:33.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:80:0)
[11:41:33.302] Timer tick, asking Buildbucket for the build status
[11:41:33.622] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:33.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:81:0) after 1m0s
[11:42:33.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:81:0)
[11:42:33.630] Timer tick, asking Buildbucket for the build status
[11:42:33.689] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:33.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:82:0) after 1m0s
[11:43:33.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:82:0)
[11:43:33.709] Timer tick, asking Buildbucket for the build status
[11:43:33.802] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:33.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:83:0) after 1m0s
[11:44:33.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:83:0)
[11:44:33.824] Timer tick, asking Buildbucket for the build status
[11:44:34.083] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:34.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:84:0) after 1m0s
[11:45:34.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:84:0)
[11:45:34.160] Timer tick, asking Buildbucket for the build status
[11:45:34.234] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:34.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:85:0) after 1m0s
[11:46:34.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:85:0)
[11:46:34.307] Timer tick, asking Buildbucket for the build status
[11:46:34.682] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:34.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:86:0) after 1m0s
[11:47:34.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:86:0)
[11:47:34.703] Timer tick, asking Buildbucket for the build status
[11:47:34.772] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:34.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:87:0) after 1m0s
[11:48:34.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:87:0)
[11:48:34.879] Timer tick, asking Buildbucket for the build status
[11:48:35.193] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:35.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:88:0) after 1m0s
[11:49:35.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:88:0)
[11:49:35.194] Timer tick, asking Buildbucket for the build status
[11:49:35.393] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:35.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:89:0) after 1m0s
[11:50:35.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:89:0)
[11:50:35.457] Timer tick, asking Buildbucket for the build status
[11:50:35.516] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:35.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:90:0) after 1m0s
[11:51:35.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:90:0)
[11:51:35.589] Timer tick, asking Buildbucket for the build status
[11:51:35.690] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:35.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:91:0) after 1m0s
[11:52:35.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:91:0)
[11:52:35.752] Timer tick, asking Buildbucket for the build status
[11:52:36.019] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:36.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:92:0) after 1m0s
[11:53:36.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:92:0)
[11:53:36.166] Timer tick, asking Buildbucket for the build status
[11:53:36.276] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:36.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:93:0) after 1m0s
[11:54:36.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:93:0)
[11:54:36.300] Timer tick, asking Buildbucket for the build status
[11:54:36.352] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:36.352] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:94:0) after 1m0s
[11:55:36.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:94:0)
[11:55:36.391] Timer tick, asking Buildbucket for the build status
[11:55:36.631] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:36.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:95:0) after 1m0s
[11:56:36.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:95:0)
[11:56:36.705] Timer tick, asking Buildbucket for the build status
[11:56:36.806] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:36.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:96:0) after 1m0s
[11:57:36.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:96:0)
[11:57:36.828] Timer tick, asking Buildbucket for the build status
[11:57:36.942] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:36.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:97:0) after 1m0s
[11:58:36.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:97:0)
[11:58:36.931] Timer tick, asking Buildbucket for the build status
[11:58:37.047] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:37.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:98:0) after 1m0s
[11:59:37.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:98:0)
[11:59:37.072] Timer tick, asking Buildbucket for the build status
[11:59:37.185] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:37.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:99:0) after 1m0s
[12:00:37.210] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:99:0)
[12:00:37.210] Timer tick, asking Buildbucket for the build status
[12:00:37.870] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:37.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:100:0) after 1m0s
[12:01:37.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:100:0)
[12:01:37.945] Timer tick, asking Buildbucket for the build status
[12:01:38.581] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:38.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:101:0) after 1m0s
[12:02:38.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:101:0)
[12:02:38.689] Timer tick, asking Buildbucket for the build status
[12:02:38.884] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:38.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:102:0) after 1m0s
[12:03:38.941] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:102:0)
[12:03:38.941] Timer tick, asking Buildbucket for the build status
[12:03:39.066] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:39.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:103:0) after 1m0s
[12:04:39.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:103:0)
[12:04:39.099] Timer tick, asking Buildbucket for the build status
[12:04:39.269] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:39.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:104:0) after 1m0s
[12:05:39.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:104:0)
[12:05:39.294] Timer tick, asking Buildbucket for the build status
[12:05:39.391] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:39.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:105:0) after 1m0s
[12:06:39.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:105:0)
[12:06:39.458] Timer tick, asking Buildbucket for the build status
[12:06:39.585] Build 8865474819229719984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:39.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9030904881789842384:106:0) after 1m0s
[12:07:01.353] Received PubSub notification, asking Buildbucket for the build status
[12:07:01.422] Build 8865474819229719984: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:07:01.422] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603627620046502",
"created_by": "project:chromium",
"created_ts": "1603621384362181",
"id": "8865474819229719984",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9be30fc3958f86f2a3151bd5b30b96ea4c444c65\"}}",
"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\": \"9be30fc3958f86f2a3151bd5b30b96ea4c444c65\", \"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-42-h74j\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42241, \"got_angle_revision\": \"7a0263547cda936b320d80c650b69d7522ee1a9f\", \"got_dawn_revision\": \"42103bc2e911144745d8d8930b07ba7e58553a34\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"9be30fc3958f86f2a3151bd5b30b96ea4c444c65\", \"got_revision_cp\": \"refs/heads/master@{#820610}\", \"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\": \"9be30fc3958f86f2a3151bd5b30b96ea4c444c65\", \"swarm_hashes_refs/heads/master(at){#820610}_without_patch\": {\"absl_hardening_tests\": \"688545d994f6532d7f0b85189d8f075c04666cf9\", \"accessibility_unittests\": \"3fd668c03d0b326bcee7017f62235b26b345e964\", \"angle_unittests\": \"edf535c474337c6c4dfe3adea646df621b9c5ee1\", \"app_list_unittests\": \"2e3573bdc5aeba76edf137ba24061708d2715a52\", \"app_shell_unittests\": \"df3a5ffd2536a11ef79ab7ad5dd362e728b675b4\", \"ash_unittests\": \"9c3c3c2b9363d74bebfc3631802b072d92ecab43\", \"aura_unittests\": \"2d83bce9bf6cf54a01b23081cd01a8dbe8ef9a17\", \"base_unittests\": \"b09c045939ac0f926d03a4cd13aea2a3e9399128\", \"base_util_unittests\": \"663d99147321ca41b0dc4bdd5e9016d09cd69722\", \"blink_common_unittests\": \"94dc8bc5e884f651a97c174a31855aebf2ca5456\", \"blink_fuzzer_unittests\": \"960cb38bcc71891a97ff551a1fa6d92ce38fc390\", \"blink_heap_unittests\": \"53d6ad7e3d5f4583845ff32fb1c34b46254edc3c\", \"blink_platform_unittests\": \"f672084fc62b3b4218f6d2316ed000d2a2b994e1\", \"blink_unittests\": \"45f88f62030de290ef6a288a7e3dcc1d11c3d713\", \"boringssl_crypto_tests\": \"5623290ab35bb3a9e56d9c02ef041d8399cb2408\", \"boringssl_ssl_tests\": \"890ac51bfa579d02ed27dbcd8425714c0af2ed42\", \"browser_tests\": \"6bd8ea381700e9e83a66206a27204c7fb99ec0f2\", \"capture_unittests\": \"83fb36f2354781be040ab7f98a70a2254e22fa04\", \"cast_unittests\": \"4d5478da926fcfe829ba9aea65666298d03b1ed4\", \"cc_unittests\": \"5f5e814240e3bec069997f5c3f9bceb43ba26510\", \"chrome_app_unittests\": \"751d5cd99be9f5fa75a1128eed89d0775f2ab7c5\", \"chromedriver_unittests\": \"3dc557f51e5549a7fd15a3c75a51262656eebd8e\", \"chromeos_components_unittests\": \"58a5c83ce32f31cdc95b77b0a81ed57e5c4aa159\", \"chromeos_unittests\": \"d128582bc4a54615dffa0dbf8731d4f51e798be0\", \"components_browsertests\": \"53832cf8e2d3d057d3629a931aa4677b6200964e\", \"components_unittests\": \"d79d7f24a9f86f06f2178ef7919dc5b480a4d875\", \"compositor_unittests\": \"f31a096f27960e38b0380ed8ff3322cd4726ecb7\", \"content_browsertests\": \"255170be788ca2ec8e696a19bcf03ce4dec32893\", \"content_unittests\": \"0754416d433992bccafe82f912a1cfcd4863fd52\", \"crypto_unittests\": \"1b5dd23cfac7a6653dad131544295ff13eba92c5\", \"dbus_unittests\": \"8eb7d227c09c9fa029fee5cb948fe3cca71708d8\", \"device_unittests\": \"1107ce1319a4e4a0345f91ab7eb492767193ca04\", \"display_unittests\": \"ca5bc9425fb7bc3959ba38e0ec687444c29d55db\", \"events_unittests\": \"b388d6e04ad5c8c35c709e2ea61e48dad37d32c6\", \"exo_unittests\": \"d2aca5f6cb62a24b5b8d1963241386657380ce98\", \"extensions_browsertests\": \"439c8b42f6baa73cb3c3ee3c36dc5cd1235006fa\", \"extensions_unittests\": \"32b7434fd26494578b8f9d36a5f3fa729d13ee81\", \"filesystem_service_unittests\": \"110cea0c2c474c12e8804765745c3297684ec362\", \"gcm_unit_tests\": \"e3fdee2867e650f1329e2f610ecaee59e2a4b75f\", \"gfx_unittests\": \"6080128caff57aecf88a02c9648366c794367d20\", \"gin_unittests\": \"6b5f99ec5703e0e7e7dd1e745326042351302b7b\", \"gl_unittests_ozone\": \"84332d896de1887007510613aff9ee7235f62b49\", \"google_apis_unittests\": \"3755fdba12a83b5e35a50ea12362ab3b38dc9498\", \"gpu_unittests\": \"2643abc398c8c4d186bd76b72f6163f097b22575\", \"gwp_asan_unittests\": \"48e4085ea948aef88fec7f62fb96e8d5e9420e29\", \"interactive_ui_tests\": \"d642d80767ce94c6d10e4b3c1a53a0cf63325b1d\", \"ipc_tests\": \"3d79c078491eee4c48ed631d4fd4154808480700\", \"jingle_unittests\": \"450528fc7493d85aa692e4cd7cadcdc3bff3dcff\", \"keyboard_unittests\": \"0d8cbc3b5ef3de25147437cb266237c4d2d94ef5\", \"latency_unittests\": \"13b1e20efd05c0c57537ddf5f28fb4d58acbf6ac\", \"libjingle_xmpp_unittests\": \"1266a0eede82b2671dd66a5417c7e1c8653b8c09\", \"media_blink_unittests\": \"65ed0929817bb81666ce3ec1bdb62ca1c6479106\", \"media_unittests\": \"ea06ac9c8d3afbb8f8be4094cc3f8b600adbfe2a\", \"message_center_unittests\": \"5cc6821146745ff4c7f7b2ed337ead85582c00a3\", \"midi_unittests\": \"dab0b1ccfe5b85065c27d38555fb7e75352acd3d\", \"mojo_core_unittests\": \"3406d38dc4e359a1f573dd8b13b684c659cf2348\", \"mojo_unittests\": \"e6feed74142c41fbea99589845ab175452e34a5a\", \"nacl_helper_nonsfi_unittests\": \"66cb5a98a4c30875ec3e22118c472788989ba1c0\", \"nacl_loader_unittests\": \"2a3450fae82adab054e436bdd17dd5423dbb3143\", \"native_theme_unittests\": \"ef47cddf9401de3326f3af11516fb231a446a3f4\", \"net_unittests\": \"47f716b67dbb48bf6ddd412178b61a8359e7f5dc\", \"ozone_gl_unittests\": \"3997b3e74fea7313a8191dd80949854b6870006f\", \"ozone_unittests\": \"d7a43f8e83f4447e11070020a2ff7cc8916b1aa6\", \"ozone_x11_unittests\": \"f9863df7d6ccae17fef955b99895de3db278c429\", \"pdf_unittests\": \"148a0af0515180ce1d21ac25bf5b6a587ae592cf\", \"perfetto_unittests\": \"650ae8effb6795b98a4f3d8b73dc4e60efa21f83\", \"ppapi_unittests\": \"762deaf974b7cc7702de2c53c3d84ba5603c6709\", \"printing_unittests\": \"6b0ebc7b68847665c2911e0ee5a4ea858ab7e7fd\", \"remoting_unittests\": \"19e9b9a813cff51c4f23a4b2b4171278e2cb24a9\", \"sandbox_linux_unittests\": \"fea96530565e0495689ed51085234f0f4494f882\", \"service_manager_unittests\": \"f8b680c9320976df811c4bc44626524b93154985\", \"services_unittests\": \"d56344295d61bf59f4cea4287fd706064ed142c4\", \"shell_dialogs_unittests\": \"a8b70d8a6548f3836fd1761c7b840c281733f712\", \"skia_unittests\": \"c2ec6a33a7f7c4cad390c2583f32202342cdfba8\", \"snapshot_unittests\": \"1393466d5a372d8390038e9b598d34bac65f4a97\", \"sql_unittests\": \"7ff19f23e7da379c1e49c06030f603fe8169a7d3\", \"storage_unittests\": \"6869f87d0af2605ddab5e53e5ec70f65c0ec3f8b\", \"sync_integration_tests\": \"d910a6bb5e0743eaa99d0fb93cae1879ac63dbf9\", \"traffic_annotation_auditor_unittests\": \"cf2898cbd3f186471bc7ae6d318847db1881bdea\", \"ui_base_unittests\": \"6321f5d9586c5e05bca9bb25aca2384c0b9ad5b4\", \"ui_chromeos_unittests\": \"0a178c0528d4189f39e57bfa6e485aaf2f09f8f5\", \"ui_touch_selection_unittests\": \"083b952cffac8c1327ed38adf2cf17a2e9016a77\", \"unit_tests\": \"9e8b4d61e80ba7d8a87b252d368ea1e7c725e7ce\", \"url_unittests\": \"ac74ef8e2bbb2e907ec44d67b2c5203cb61977a7\", \"usage_time_limit_unittests\": \"bc8678fde5f51ef189cc7dffad12397e2cb4445f\", \"views_unittests\": \"46c208c5bd83218005b120a41926df512e782adb\", \"viz_unittests\": \"31692ea87f35348833e8291ac469e252758ca4c0\", \"wayland_client_perftests\": \"29a711bf12616b0f806c5e05926f36354fcad79d\", \"wm_unittests\": \"059ef546c30ed88e0e05945e8358d0f1144b0acd\", \"wtf_unittests\": \"6249fa41e4798532b7772595d13b5f6b223ce02d\", \"zlib_unittests\": \"6ca90be974f4fe5e8a10d9ae601dea0e2dff5ec2\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1267e646917891f5f926cdb94ab3368f0c9399d68d76518d691afb23f68811c9_v2\", \"builder_51829829c31fbaf3768e3309e640f1ed37e0867e138bde8c875431bcab07adc2_v2\", \"builder_dacf669b49e3ec352df995227b58e62a545590985cca62e76e0831f920af4ccd_v2\", \"builder_dc45faf1d7d5fa61c97a020287f0c8532c944f5ffcf96875ec590f5c9bab0d83_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-42-h74j\"], \"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-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603622721875549",
"status": "COMPLETED",
"status_changed_ts": "1603627620389915",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42241",
"builder:linux-chromeos-rel",
"buildset:commit/git/9be30fc3958f86f2a3151bd5b30b96ea4c444c65",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9be30fc3958f86f2a3151bd5b30b96ea4c444c65",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030904881789842384",
"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/8865474819229719984/+/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:4f7819fc627d0510",
"user_agent:luci-scheduler"
],
"updated_ts": "1603627620405281",
"url": "https://ci.chromium.org/b/8865474819229719984",
"utcnow_ts": "1603627621410965"
}
}
[12:07:01.422] Invocation finished in 1h43m58.885162069s with status SUCCEEDED