[03:34:12.865] New invocation is queued and will start shortly
[03:34:14.121] Starting the invocation (attempt 1)
[03:34:14.158] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:34:14.158] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:34:14.158] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022776876057708384",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e15c2495adef003f8c186c45d7b15215e3e54895\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9022776876057708384",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/e15c2495adef003f8c186c45d7b15215e3e54895",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e15c2495adef003f8c186c45d7b15215e3e54895",
"gitiles_ref:refs/heads/master"
]
}
[03:34:14.936] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611372854267582",
"id": "8857346813922080880",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e15c2495adef003f8c186c45d7b15215e3e54895\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611372854687959",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44843",
"builder:linux-chromeos-rel",
"buildset:commit/git/e15c2495adef003f8c186c45d7b15215e3e54895",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e15c2495adef003f8c186c45d7b15215e3e54895",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022776876057708384",
"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/8857346813922080880/+/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": "1611372854688130",
"url": "https://ci.chromium.org/b/8857346813922080880",
"utcnow_ts": "1611372854928566"
}
}
[03:34:14.936] Task URL: https://ci.chromium.org/b/8857346813922080880
[03:34:14.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:2:0) after 1m0s
[03:35:15.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:2:0)
[03:35:15.148] Timer tick, asking Buildbucket for the build status
[03:35:15.309] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:35:15.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:3:0) after 1m0s
[03:36:15.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:3:0)
[03:36:15.474] Timer tick, asking Buildbucket for the build status
[03:36:15.605] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:36:15.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:4:0) after 1m0s
[03:37:15.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:4:0)
[03:37:15.677] Timer tick, asking Buildbucket for the build status
[03:37:15.745] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:37:15.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:5:0) after 1m0s
[03:38:15.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:5:0)
[03:38:15.860] Timer tick, asking Buildbucket for the build status
[03:38:15.939] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:38:15.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:6:0) after 1m0s
[03:39:16.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:6:0)
[03:39:16.122] Timer tick, asking Buildbucket for the build status
[03:39:16.272] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:39:16.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:7:0) after 1m0s
[03:40:16.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:7:0)
[03:40:16.334] Timer tick, asking Buildbucket for the build status
[03:40:16.737] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:40:16.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:8:0) after 1m0s
[03:41:16.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:8:0)
[03:41:16.811] Timer tick, asking Buildbucket for the build status
[03:41:17.005] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:41:17.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:9:0) after 1m0s
[03:42:17.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:9:0)
[03:42:17.144] Timer tick, asking Buildbucket for the build status
[03:42:17.337] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:42:17.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:10:0) after 1m0s
[03:43:17.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:10:0)
[03:43:17.447] Timer tick, asking Buildbucket for the build status
[03:43:17.513] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:43:17.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:11:0) after 1m0s
[03:44:17.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:11:0)
[03:44:17.527] Timer tick, asking Buildbucket for the build status
[03:44:17.775] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:44:17.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:12:0) after 1m0s
[03:45:17.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:12:0)
[03:45:17.942] Timer tick, asking Buildbucket for the build status
[03:45:18.017] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:45:18.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:13:0) after 1m0s
[03:46:18.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:13:0)
[03:46:18.042] Timer tick, asking Buildbucket for the build status
[03:46:18.171] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:46:18.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:14:0) after 1m0s
[03:47:18.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:14:0)
[03:47:18.190] Timer tick, asking Buildbucket for the build status
[03:47:18.510] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:47:18.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:15:0) after 1m0s
[03:48:18.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:15:0)
[03:48:18.603] Timer tick, asking Buildbucket for the build status
[03:48:18.923] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:48:18.924] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:16:0) after 1m0s
[03:49:19.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:16:0)
[03:49:19.032] Timer tick, asking Buildbucket for the build status
[03:49:19.120] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:49:19.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:17:0) after 1m0s
[03:50:19.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:17:0)
[03:50:19.162] Timer tick, asking Buildbucket for the build status
[03:50:19.224] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:50:19.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:18:0) after 1m0s
[03:51:19.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:18:0)
[03:51:19.284] Timer tick, asking Buildbucket for the build status
[03:51:19.457] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:51:19.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:19:0) after 1m0s
[03:52:19.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:19:0)
[03:52:19.455] Timer tick, asking Buildbucket for the build status
[03:52:19.556] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:52:19.556] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:20:0) after 1m0s
[03:53:19.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:20:0)
[03:53:19.620] Timer tick, asking Buildbucket for the build status
[03:53:19.699] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:53:19.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:21:0) after 1m0s
[03:54:19.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:21:0)
[03:54:19.739] Timer tick, asking Buildbucket for the build status
[03:54:19.847] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:54:19.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:22:0) after 1m0s
[03:55:19.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:22:0)
[03:55:19.891] Timer tick, asking Buildbucket for the build status
[03:55:19.980] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:55:19.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:23:0) after 1m0s
[03:56:20.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:23:0)
[03:56:20.011] Timer tick, asking Buildbucket for the build status
[03:56:20.097] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:56:20.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:24:0) after 1m0s
[03:57:20.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:24:0)
[03:57:20.116] Timer tick, asking Buildbucket for the build status
[03:57:20.254] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:57:20.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:25:0) after 1m0s
[03:58:20.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:25:0)
[03:58:20.290] Timer tick, asking Buildbucket for the build status
[03:58:20.370] Build 8857346813922080880: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:58:20.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:26:0) after 1m0s
[03:58:43.400] Received PubSub notification, asking Buildbucket for the build status
[03:58:43.474] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:20.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:26:0)
[03:59:20.426] Timer tick, asking Buildbucket for the build status
[03:59:21.142] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:21.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:28:0) after 1m0s
[04:00:21.231] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:28:0)
[04:00:21.231] Timer tick, asking Buildbucket for the build status
[04:00:23.228] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:23.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:29:0) after 1m0s
[04:01:23.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:29:0)
[04:01:23.544] Timer tick, asking Buildbucket for the build status
[04:01:23.643] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:23.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:30:0) after 1m0s
[04:02:23.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:30:0)
[04:02:23.773] Timer tick, asking Buildbucket for the build status
[04:02:23.889] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:23.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:31:0) after 1m0s
[04:03:24.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:31:0)
[04:03:24.168] Timer tick, asking Buildbucket for the build status
[04:03:24.237] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:24.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:32:0) after 1m0s
[04:04:24.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:32:0)
[04:04:24.387] Timer tick, asking Buildbucket for the build status
[04:04:24.532] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:24.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:33:0) after 1m0s
[04:05:24.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:33:0)
[04:05:24.639] Timer tick, asking Buildbucket for the build status
[04:05:24.802] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:24.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:34:0) after 1m0s
[04:06:24.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:34:0)
[04:06:24.883] Timer tick, asking Buildbucket for the build status
[04:06:25.204] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:25.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:35:0) after 1m0s
[04:07:25.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:35:0)
[04:07:25.240] Timer tick, asking Buildbucket for the build status
[04:07:25.318] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:25.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:36:0) after 1m0s
[04:08:25.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:36:0)
[04:08:25.415] Timer tick, asking Buildbucket for the build status
[04:08:25.500] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:25.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:37:0) after 1m0s
[04:09:25.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:37:0)
[04:09:25.607] Timer tick, asking Buildbucket for the build status
[04:09:25.730] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:25.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:38:0) after 1m0s
[04:10:25.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:38:0)
[04:10:25.715] Timer tick, asking Buildbucket for the build status
[04:10:25.883] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:25.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:39:0) after 1m0s
[04:11:25.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:39:0)
[04:11:25.870] Timer tick, asking Buildbucket for the build status
[04:11:25.972] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:25.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:40:0) after 1m0s
[04:12:25.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:40:0)
[04:12:25.979] Timer tick, asking Buildbucket for the build status
[04:12:26.094] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:26.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:41:0) after 1m0s
[04:13:26.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:41:0)
[04:13:26.160] Timer tick, asking Buildbucket for the build status
[04:13:26.222] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:26.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:42:0) after 1m0s
[04:14:26.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:42:0)
[04:14:26.253] Timer tick, asking Buildbucket for the build status
[04:14:26.383] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:26.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:43:0) after 1m0s
[04:15:26.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:43:0)
[04:15:26.404] Timer tick, asking Buildbucket for the build status
[04:15:26.470] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:26.470] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:44:0) after 1m0s
[04:16:26.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:44:0)
[04:16:26.533] Timer tick, asking Buildbucket for the build status
[04:16:26.587] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:26.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:45:0) after 1m0s
[04:17:26.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:45:0)
[04:17:26.656] Timer tick, asking Buildbucket for the build status
[04:17:26.735] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:26.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:46:0) after 1m0s
[04:18:27.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:46:0)
[04:18:27.638] Timer tick, asking Buildbucket for the build status
[04:18:27.700] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:27.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:47:0) after 1m0s
[04:19:28.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:47:0)
[04:19:28.220] Timer tick, asking Buildbucket for the build status
[04:19:28.846] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:28.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:48:0) after 1m0s
[04:20:28.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:48:0)
[04:20:28.929] Timer tick, asking Buildbucket for the build status
[04:20:29.062] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:29.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:49:0) after 1m0s
[04:21:29.107] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:49:0)
[04:21:29.107] Timer tick, asking Buildbucket for the build status
[04:21:29.324] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:29.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:50:0) after 1m0s
[04:22:29.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:50:0)
[04:22:29.408] Timer tick, asking Buildbucket for the build status
[04:22:29.617] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:29.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:51:0) after 1m0s
[04:23:29.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:51:0)
[04:23:29.663] Timer tick, asking Buildbucket for the build status
[04:23:29.816] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:29.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:52:0) after 1m0s
[04:24:29.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:52:0)
[04:24:29.856] Timer tick, asking Buildbucket for the build status
[04:24:30.192] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:30.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:53:0) after 1m0s
[04:25:30.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:53:0)
[04:25:30.264] Timer tick, asking Buildbucket for the build status
[04:25:34.014] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:34.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:54:0) after 1m0s
[04:26:34.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:54:0)
[04:26:34.022] Timer tick, asking Buildbucket for the build status
[04:26:34.099] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:34.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:55:0) after 1m0s
[04:27:34.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:55:0)
[04:27:34.121] Timer tick, asking Buildbucket for the build status
[04:27:34.197] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:34.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:56:0) after 1m0s
[04:28:34.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:56:0)
[04:28:34.217] Timer tick, asking Buildbucket for the build status
[04:28:34.285] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:34.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:57:0) after 1m0s
[04:29:34.358] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:57:0)
[04:29:34.358] Timer tick, asking Buildbucket for the build status
[04:29:34.486] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:34.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:58:0) after 1m0s
[04:30:34.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:58:0)
[04:30:34.588] Timer tick, asking Buildbucket for the build status
[04:30:34.827] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:34.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:59:0) after 1m0s
[04:31:34.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:59:0)
[04:31:34.928] Timer tick, asking Buildbucket for the build status
[04:31:34.985] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:34.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:60:0) after 1m0s
[04:32:35.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:60:0)
[04:32:35.023] Timer tick, asking Buildbucket for the build status
[04:32:35.089] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:35.089] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:61:0) after 1m0s
[04:33:35.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:61:0)
[04:33:35.121] Timer tick, asking Buildbucket for the build status
[04:33:35.231] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:35.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:62:0) after 1m0s
[04:34:35.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:62:0)
[04:34:35.281] Timer tick, asking Buildbucket for the build status
[04:34:35.523] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:35.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:63:0) after 1m0s
[04:35:35.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:63:0)
[04:35:35.722] Timer tick, asking Buildbucket for the build status
[04:35:35.892] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:35.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:64:0) after 1m0s
[04:36:36.080] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:64:0)
[04:36:36.080] Timer tick, asking Buildbucket for the build status
[04:36:36.234] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:36.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:65:0) after 1m0s
[04:37:36.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:65:0)
[04:37:36.312] Timer tick, asking Buildbucket for the build status
[04:37:36.490] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:36.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:66:0) after 1m0s
[04:38:36.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:66:0)
[04:38:36.549] Timer tick, asking Buildbucket for the build status
[04:38:36.617] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:36.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:67:0) after 1m0s
[04:39:36.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:67:0)
[04:39:36.641] Timer tick, asking Buildbucket for the build status
[04:39:37.354] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:37.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:68:0) after 1m0s
[04:40:37.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:68:0)
[04:40:37.490] Timer tick, asking Buildbucket for the build status
[04:40:37.631] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:37.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:69:0) after 1m0s
[04:41:37.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:69:0)
[04:41:37.645] Timer tick, asking Buildbucket for the build status
[04:41:38.531] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:38.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:70:0) after 1m0s
[04:42:38.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:70:0)
[04:42:38.580] Timer tick, asking Buildbucket for the build status
[04:42:38.634] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:38.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:71:0) after 1m0s
[04:43:38.680] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:71:0)
[04:43:38.680] Timer tick, asking Buildbucket for the build status
[04:43:38.760] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:38.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:72:0) after 1m0s
[04:44:38.849] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:72:0)
[04:44:38.849] Timer tick, asking Buildbucket for the build status
[04:44:38.948] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:38.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:73:0) after 1m0s
[04:45:39.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:73:0)
[04:45:39.012] Timer tick, asking Buildbucket for the build status
[04:45:39.069] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:39.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:74:0) after 1m0s
[04:46:39.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:74:0)
[04:46:39.229] Timer tick, asking Buildbucket for the build status
[04:46:39.291] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:39.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:75:0) after 1m0s
[04:47:39.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:75:0)
[04:47:39.393] Timer tick, asking Buildbucket for the build status
[04:47:39.462] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:39.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:76:0) after 1m0s
[04:48:39.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:76:0)
[04:48:39.562] Timer tick, asking Buildbucket for the build status
[04:48:40.311] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:40.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:77:0) after 1m0s
[04:49:40.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:77:0)
[04:49:40.338] Timer tick, asking Buildbucket for the build status
[04:49:41.046] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:41.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:78:0) after 1m0s
[04:50:41.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:78:0)
[04:50:41.069] Timer tick, asking Buildbucket for the build status
[04:50:42.169] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:42.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:79:0) after 1m0s
[04:51:42.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:79:0)
[04:51:42.347] Timer tick, asking Buildbucket for the build status
[04:51:42.434] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:42.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:80:0) after 1m0s
[04:52:42.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:80:0)
[04:52:42.506] Timer tick, asking Buildbucket for the build status
[04:52:42.610] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:42.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:81:0) after 1m0s
[04:53:42.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:81:0)
[04:53:42.690] Timer tick, asking Buildbucket for the build status
[04:53:42.750] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:42.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:82:0) after 1m0s
[04:54:42.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:82:0)
[04:54:42.868] Timer tick, asking Buildbucket for the build status
[04:54:43.033] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:43.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:83:0) after 1m0s
[04:55:43.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:83:0)
[04:55:43.151] Timer tick, asking Buildbucket for the build status
[04:55:43.243] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:43.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:84:0) after 1m0s
[04:56:43.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:84:0)
[04:56:43.266] Timer tick, asking Buildbucket for the build status
[04:56:43.340] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:43.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:85:0) after 1m0s
[04:57:43.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:85:0)
[04:57:43.380] Timer tick, asking Buildbucket for the build status
[04:57:44.495] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:44.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:86:0) after 1m0s
[04:58:44.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:86:0)
[04:58:44.487] Timer tick, asking Buildbucket for the build status
[04:58:44.576] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:44.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:87:0) after 1m0s
[04:59:44.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:87:0)
[04:59:44.606] Timer tick, asking Buildbucket for the build status
[04:59:45.005] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:45.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:88:0) after 1m0s
[05:00:45.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:88:0)
[05:00:45.243] Timer tick, asking Buildbucket for the build status
[05:00:45.346] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:45.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:89:0) after 1m0s
[05:01:45.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:89:0)
[05:01:45.483] Timer tick, asking Buildbucket for the build status
[05:01:46.003] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:46.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:90:0) after 1m0s
[05:02:46.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:90:0)
[05:02:46.028] Timer tick, asking Buildbucket for the build status
[05:02:46.196] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:46.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:91:0) after 1m0s
[05:03:46.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:91:0)
[05:03:46.261] Timer tick, asking Buildbucket for the build status
[05:03:46.357] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:46.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:92:0) after 1m0s
[05:04:46.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:92:0)
[05:04:46.414] Timer tick, asking Buildbucket for the build status
[05:04:46.541] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:46.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:93:0) after 1m0s
[05:05:46.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:93:0)
[05:05:46.725] Timer tick, asking Buildbucket for the build status
[05:05:46.804] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:46.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:94:0) after 1m0s
[05:06:46.855] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:94:0)
[05:06:46.855] Timer tick, asking Buildbucket for the build status
[05:06:46.938] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:46.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:95:0) after 1m0s
[05:07:46.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:95:0)
[05:07:46.959] Timer tick, asking Buildbucket for the build status
[05:07:47.118] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:47.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:96:0) after 1m0s
[05:08:47.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:96:0)
[05:08:47.144] Timer tick, asking Buildbucket for the build status
[05:08:47.338] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:47.338] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:97:0) after 1m0s
[05:09:47.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:97:0)
[05:09:47.444] Timer tick, asking Buildbucket for the build status
[05:09:47.550] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:47.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:98:0) after 1m0s
[05:10:47.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:98:0)
[05:10:47.819] Timer tick, asking Buildbucket for the build status
[05:10:47.947] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:47.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:99:0) after 1m0s
[05:11:48.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:99:0)
[05:11:48.558] Timer tick, asking Buildbucket for the build status
[05:11:48.682] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:48.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:100:0) after 1m0s
[05:12:48.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:100:0)
[05:12:48.811] Timer tick, asking Buildbucket for the build status
[05:12:48.936] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:48.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:101:0) after 1m0s
[05:13:49.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:101:0)
[05:13:49.138] Timer tick, asking Buildbucket for the build status
[05:13:49.526] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:49.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:102:0) after 1m0s
[05:14:49.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:102:0)
[05:14:49.613] Timer tick, asking Buildbucket for the build status
[05:14:49.737] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:49.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:103:0) after 1m0s
[05:15:49.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:103:0)
[05:15:49.992] Timer tick, asking Buildbucket for the build status
[05:15:50.645] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:50.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:104:0) after 1m0s
[05:16:51.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:104:0)
[05:16:51.069] Timer tick, asking Buildbucket for the build status
[05:16:51.931] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:51.931] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:105:0) after 1m0s
[05:17:51.996] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:105:0)
[05:17:51.996] Timer tick, asking Buildbucket for the build status
[05:17:52.123] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:52.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:106:0) after 1m0s
[05:18:52.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:106:0)
[05:18:52.218] Timer tick, asking Buildbucket for the build status
[05:18:52.381] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:52.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:107:0) after 1m0s
[05:19:52.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:107:0)
[05:19:52.418] Timer tick, asking Buildbucket for the build status
[05:19:52.821] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:52.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:108:0) after 1m0s
[05:20:53.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:108:0)
[05:20:53.440] Timer tick, asking Buildbucket for the build status
[05:20:53.625] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:53.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:109:0) after 1m0s
[05:21:53.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:109:0)
[05:21:53.729] Timer tick, asking Buildbucket for the build status
[05:21:53.838] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:53.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:110:0) after 1m0s
[05:22:53.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:110:0)
[05:22:53.920] Timer tick, asking Buildbucket for the build status
[05:22:54.204] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:54.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:111:0) after 1m0s
[05:23:54.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:111:0)
[05:23:54.386] Timer tick, asking Buildbucket for the build status
[05:23:54.486] Build 8857346813922080880: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:54.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022776876057708384:112:0) after 1m0s
[05:24:38.990] Received PubSub notification, asking Buildbucket for the build status
[05:24:39.067] Build 8857346813922080880: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:24:39.067] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611379477828771",
"created_by": "project:chromium",
"created_ts": "1611372854267582",
"id": "8857346813922080880",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e15c2495adef003f8c186c45d7b15215e3e54895\"}}",
"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\": \"e15c2495adef003f8c186c45d7b15215e3e54895\", \"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-26-kewh\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44843, \"got_angle_revision\": \"3c3b82abcf0a5c18b4d97ae49726045ce6d3b832\", \"got_dawn_revision\": \"f1f8394de04ea9532de763dfb2f968fc9610683b\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"e15c2495adef003f8c186c45d7b15215e3e54895\", \"got_revision_cp\": \"refs/heads/master@{#846475}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"413f7cb17c77c95e4cc3ba141f3c0f049ac2ecb2\", \"got_v8_revision\": \"83f44c53679624b80370f5d8383be83abf0be4c4\", \"got_v8_revision_cp\": \"refs/heads/9.0.56@{#1}\", \"got_webrtc_revision\": \"8c007fffead0f29650d6e34c10c85605e4dd33df\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33061}\", \"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\": \"e15c2495adef003f8c186c45d7b15215e3e54895\", \"swarm_hashes_refs/heads/master(at){#846475}_without_patch\": {\"absl_hardening_tests\": \"dc8b38ebc42465c367c58e6d3e8de1108c0485ea\", \"accessibility_unittests\": \"b9ad57a3c4bc93a08fbb911db162846d78b75ff3\", \"angle_unittests\": \"150b62cd2bb404a34f8a3847addd087549785132\", \"app_list_unittests\": \"a109d3e89a47b815a0caab0e5918ffae62d2670c\", \"app_shell_unittests\": \"690244b272cb8540f05b6d1611cc1df60285a2e6\", \"ash_unittests\": \"beb7dff600c257272e039a679517c40e3e7e1565\", \"aura_unittests\": \"52385e7d716ed43997316ff7306214c66f58c6d0\", \"base_unittests\": \"f9677475ead2d64a87e127095ad503f563301910\", \"base_util_unittests\": \"1711cec61f972988ee4a3bc0a4fa5ba8f3a6254f\", \"blink_common_unittests\": \"b71eb14d89d8bad1cfc011cc9d7e47c3c75ee500\", \"blink_fuzzer_unittests\": \"8436b47eb9515e5a0b1a0592f584a1ef1d29c952\", \"blink_heap_unittests\": \"6f2358886712eec883e12c0261c5247cde508596\", \"blink_platform_unittests\": \"d833b1f268d981d64185c0d29ebdb16adce87cff\", \"blink_unittests\": \"33f8b725bee3c99ce6b9fc55a912c05dd713379b\", \"boringssl_crypto_tests\": \"abb21a9d81ef53bf0aa894159ec6c993d37d86c5\", \"boringssl_ssl_tests\": \"893eaaf4e8dbe8dc13ffca109d8c377487c21d4b\", \"browser_tests\": \"afc120593d7a80899246c3288b22296b7ffcecfc\", \"capture_unittests\": \"0e1a6c0df9408d5d85dd9702c0b6ef21ae51e97b\", \"cast_unittests\": \"7e076a49e77cc659e00b077daf3697c9379080bd\", \"cc_unittests\": \"a090ad93e1db22e91c498e7b5ec4b33eaabf75b3\", \"chrome_app_unittests\": \"fbb01fe3d6ddd316121c605d549a3a70e5a73911\", \"chromedriver_unittests\": \"c51d0d22f36d0093775c76ed12cfd5a58e85fc8f\", \"chromeos_components_unittests\": \"18ba978a02933b1374b4d48b3c7f188bf60b6f58\", \"chromeos_unittests\": \"d5179a3a792be65098a3cdf612fdbabdf215d970\", \"components_browsertests\": \"a2e914966b0f440bae59b41d628bcb00b84c85f1\", \"components_unittests\": \"735b88bc353155c98a763470f35051f0a02583ee\", \"compositor_unittests\": \"a42583797e03983582b3b12c8fda8073e422553c\", \"content_browsertests\": \"5a372285232bd9d2b170c7f51b815d1efc7df279\", \"content_unittests\": \"ec9a3537c6bb90c86a288c5fb7e8f2fb567af36d\", \"crashpad_tests\": \"9b0ec78c8de3edbf9854f1759e7d6f0aa43016e2\", \"crypto_unittests\": \"d1924de36263a039e18e935829cd5e9b67652807\", \"dbus_unittests\": \"dad2c97c0f50008c7bfcc704b4a207e35b5ad83e\", \"device_unittests\": \"06870f9b3d168b51368c15447eaa73cd133a96fb\", \"display_unittests\": \"3a65532af0783629e2caa2588c57d7ca1506052f\", \"events_unittests\": \"f45ae6e550e3c9132880a29cbc90d0a07fb4a4ae\", \"exo_unittests\": \"4be05cc5cd28c4378da8f04f9585659cb06e3867\", \"extensions_browsertests\": \"add42d1d6e11d0eab2fa5dfa8cfe0f3818ff2c95\", \"extensions_unittests\": \"154bade9df4b6df96a5f90ff0a98ecd9bed3c575\", \"filesystem_service_unittests\": \"f3645f858beab7608ca334ff15b113cf9e9b42e8\", \"gcm_unit_tests\": \"ead01d3dd15521b1f85939770d82d26651f0f187\", \"gfx_unittests\": \"54a7c53261e6e74befde8b89566121fb9a92256a\", \"gin_unittests\": \"5fb6f35a9618a034868710de16d5abdf55c399a5\", \"gl_unittests_ozone\": \"030a46a426329e09ad757d45fbb57d23a9b8eaba\", \"google_apis_unittests\": \"3b17666821ff4831b900040dac9c703d74f1ea38\", \"gpu_unittests\": \"c71253d3b643c2ec64c7d44f414a7d524feab732\", \"gwp_asan_unittests\": \"f1be1054495054629e5b1666c62451b9efd14910\", \"interactive_ui_tests\": \"4ab053f9006d8f975e4b7b6f948430cdf4dccc35\", \"ipc_tests\": \"17177319d58a31df42cfe2c44ed8a99a3bdc4b56\", \"jingle_unittests\": \"c6a702f1a6fc0da5a00d87a9bbe2ceebf9847d97\", \"keyboard_unittests\": \"ac0bfc4865e28ceec4cc108e2d1bc2c3af249f28\", \"latency_unittests\": \"344bc5028fa0ffbb6374b17540575f3c464b6b3d\", \"libjingle_xmpp_unittests\": \"f92be00472da8c5bb4dcd6e8b46e7a9124ad8c30\", \"liburlpattern_unittests\": \"ebbcdd83367f4cc4f1ee0c8590d0f132f678d58a\", \"media_blink_unittests\": \"9ea081dad3f1dbb33331ed06e8681761c219595b\", \"media_unittests\": \"60494efea3c0c9bd2c93f9265397b61440653c13\", \"message_center_unittests\": \"0c35461d28c57951702f099d163a55072d41a9d5\", \"midi_unittests\": \"00c270958fb03755e27064786c3f2f65cd82ee1e\", \"mojo_core_unittests\": \"072efe9d4d0051115acbb7e59472dd8bac1422f2\", \"mojo_unittests\": \"d73b8215f407986a7cb6cb0811402958629523de\", \"nacl_helper_nonsfi_unittests\": \"1c91a45e57519f253e3e0eaa82fc0a196a74723f\", \"nacl_loader_unittests\": \"6f45e5f193f9b741ad0cb70e3b14d59104cd2b87\", \"native_theme_unittests\": \"843f33c3d73cb224dadf05488688c3c6598c4138\", \"net_unittests\": \"6c1514a870fe08884ead4e8500197b6f4daa9e0d\", \"ozone_gl_unittests\": \"32b27df8db7f861b47f35bf2762e702f676f5392\", \"ozone_unittests\": \"49e8623828911978fa204794354fb340ef0c2f75\", \"ozone_x11_unittests\": \"b933cce963f1eb88ae5439ce1c535181889d54fc\", \"pdf_unittests\": \"c5c3934d5c3febf3879b750867e7f1715cd6299a\", \"perfetto_unittests\": \"311368dea8fc25a2a337142adb8dd3fdf3fc8e26\", \"ppapi_unittests\": \"db928991652043e623a4418ceb62572bee1dc94b\", \"printing_unittests\": \"2c72e1ea85bd62e1a8997345f1537630600e06a8\", \"remoting_unittests\": \"925fa853cee26561002fc01f9e3f563e5dcd5662\", \"sandbox_linux_unittests\": \"c753f31b215c943850c9af3838cacfb82cc24135\", \"service_manager_unittests\": \"7c7b4aa12d84dfd12806df3777ba3f7318f8085f\", \"services_unittests\": \"011b215fb724e63c7e78acf561ad609c4118303e\", \"shell_dialogs_unittests\": \"4a0ead8303b89ef018908fe0111ef31266ea0bd4\", \"shell_encryption_unittests\": \"5c6e7d145dcaf0909beb772831a165eb19f4301c\", \"skia_unittests\": \"e171e21c89d03853303d909a62655ce1035389b2\", \"snapshot_unittests\": \"fff5d6de1a229429d0fbe39b5365f57068240ef0\", \"sql_unittests\": \"51b5c2ab9ad5fa676ca57ffc7a6fdea2b6eda0b7\", \"storage_unittests\": \"0c40973fb673fb6b30039d88f1fe4d0b5170012f\", \"sync_integration_tests\": \"5e888a64008e86145fa5f514596bd08b10e28ff9\", \"traffic_annotation_auditor_unittests\": \"4ea05fc7c6b4fe4947dad88c2ca2eb2ce7c77d80\", \"ui_base_unittests\": \"b4a36fea678a72e9f6c4dafa651c418089cf8923\", \"ui_chromeos_unittests\": \"25814405cb2484438938760cbb3ccd4db888cfae\", \"ui_touch_selection_unittests\": \"2ea6568f28a1c18cf8b09b6b0d139f5ea64e52c1\", \"unit_tests\": \"18b5700571d9f03d635fff82cd3af9dee0363bfb\", \"url_unittests\": \"548723fc2aa32fe271c926ecca3d206a846c84cc\", \"usage_time_limit_unittests\": \"1d811a801c90e4bedbc5d6da943659ef3113f8a0\", \"views_unittests\": \"0e7acc54a8ff890413d03db4eee0818b7f0f1ce4\", \"viz_unittests\": \"b1f0642ef7f33e0e1d91320469d5b5ba9d8e3506\", \"wayland_client_perftests\": \"27cf9b9ec1a6cccf796c70d80bfb2134da7f26a6\", \"wm_unittests\": \"3b4e21746d051dc4b40abaebb85b01896cf7b562\", \"wtf_unittests\": \"5847b5a1f333bd7c6d1d84ded9f872d27708ba1d\", \"zlib_unittests\": \"f294d5f47ce4afba382588c892ea0fa6666a16e0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_51d5ee5ec7ab5be4393e9b79526fa63fba3d7e3260343dc2be27fb02e1ef2495_v2\", \"builder_61626c7085ee1f9730db9e25e8ceef3d7b395de70268d432aed853b8a16eb295_v2\", \"builder_678d8b556ed6d2ea4aa43b80debb7b547a1d6d4433ddff28e80ab170912c760d_v2\", \"builder_bcc6b3e5c0858529730294da730af8ea17f2c5c79b8b0dc7af4e722a8412ac73_v2\", \"builder_dacf669b49e3ec352df995227b58e62a545590985cca62e76e0831f920af4ccd_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-26-kewh\"], \"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\": [\"5671-1d9dea8\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611374322410525",
"status": "COMPLETED",
"status_changed_ts": "1611379478178831",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44843",
"builder:linux-chromeos-rel",
"buildset:commit/git/e15c2495adef003f8c186c45d7b15215e3e54895",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e15c2495adef003f8c186c45d7b15215e3e54895",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022776876057708384",
"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/8857346813922080880/+/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:51462006f17e7610",
"user_agent:luci-scheduler"
],
"updated_ts": "1611379478185922",
"url": "https://ci.chromium.org/b/8857346813922080880",
"utcnow_ts": "1611379479057776"
}
}
[05:24:39.067] Invocation finished in 1h50m26.219981418s with status SUCCEEDED