[18:18:47.067] New invocation is queued and will start shortly
[18:18:48.234] Starting the invocation (attempt 1)
[18:18:48.272] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:18:48.272] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:18:48.272] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022721223721202688",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e1782a3a845dcf848153977055691ed109b6611c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9022721223721202688",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/e1782a3a845dcf848153977055691ed109b6611c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e1782a3a845dcf848153977055691ed109b6611c",
"gitiles_ref:refs/heads/master"
]
}
[18:18:48.954] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611425928361743",
"id": "8857291161701346976",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e1782a3a845dcf848153977055691ed109b6611c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611425928766660",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44850",
"builder:linux-chromeos-rel",
"buildset:commit/git/e1782a3a845dcf848153977055691ed109b6611c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e1782a3a845dcf848153977055691ed109b6611c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022721223721202688",
"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/8857291161701346976/+/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": "1611425928766821",
"url": "https://ci.chromium.org/b/8857291161701346976",
"utcnow_ts": "1611425928935505"
}
}
[18:18:48.954] Task URL: https://ci.chromium.org/b/8857291161701346976
[18:18:48.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:2:0) after 1m0s
[18:19:49.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:2:0)
[18:19:49.004] Timer tick, asking Buildbucket for the build status
[18:19:49.164] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:19:49.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:3:0) after 1m0s
[18:20:49.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:3:0)
[18:20:49.284] Timer tick, asking Buildbucket for the build status
[18:20:49.459] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:20:49.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:4:0) after 1m0s
[18:21:49.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:4:0)
[18:21:49.475] Timer tick, asking Buildbucket for the build status
[18:21:49.540] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:21:49.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:5:0) after 1m0s
[18:22:49.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:5:0)
[18:22:49.527] Timer tick, asking Buildbucket for the build status
[18:22:49.615] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:22:49.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:6:0) after 1m0s
[18:23:49.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:6:0)
[18:23:49.636] Timer tick, asking Buildbucket for the build status
[18:23:49.830] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:23:49.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:7:0) after 1m0s
[18:24:49.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:7:0)
[18:24:49.868] Timer tick, asking Buildbucket for the build status
[18:24:49.976] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:24:49.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:8:0) after 1m0s
[18:25:49.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:8:0)
[18:25:49.958] Timer tick, asking Buildbucket for the build status
[18:25:50.102] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:25:50.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:9:0) after 1m0s
[18:26:50.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:9:0)
[18:26:50.167] Timer tick, asking Buildbucket for the build status
[18:26:50.265] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:26:50.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:10:0) after 1m0s
[18:27:50.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:10:0)
[18:27:50.370] Timer tick, asking Buildbucket for the build status
[18:27:50.720] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:27:50.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:11:0) after 1m0s
[18:28:50.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:11:0)
[18:28:50.962] Timer tick, asking Buildbucket for the build status
[18:28:51.114] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:28:51.114] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:12:0) after 1m0s
[18:29:51.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:12:0)
[18:29:51.128] Timer tick, asking Buildbucket for the build status
[18:29:51.196] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:29:51.196] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:13:0) after 1m0s
[18:30:51.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:13:0)
[18:30:51.213] Timer tick, asking Buildbucket for the build status
[18:30:51.291] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:30:51.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:14:0) after 1m0s
[18:31:51.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:14:0)
[18:31:51.305] Timer tick, asking Buildbucket for the build status
[18:31:51.414] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:31:51.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:15:0) after 1m0s
[18:32:51.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:15:0)
[18:32:51.434] Timer tick, asking Buildbucket for the build status
[18:32:51.507] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:32:51.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:16:0) after 1m0s
[18:33:51.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:16:0)
[18:33:51.608] Timer tick, asking Buildbucket for the build status
[18:33:52.000] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:33:52.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:17:0) after 1m0s
[18:34:52.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:17:0)
[18:34:52.054] Timer tick, asking Buildbucket for the build status
[18:34:52.117] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:34:52.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:18:0) after 1m0s
[18:35:52.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:18:0)
[18:35:52.184] Timer tick, asking Buildbucket for the build status
[18:35:52.281] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:35:52.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:19:0) after 1m0s
[18:36:52.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:19:0)
[18:36:52.425] Timer tick, asking Buildbucket for the build status
[18:36:52.503] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:36:52.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:20:0) after 1m0s
[18:37:53.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:20:0)
[18:37:53.701] Timer tick, asking Buildbucket for the build status
[18:37:53.779] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:37:53.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:21:0) after 1m0s
[18:38:53.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:21:0)
[18:38:53.919] Timer tick, asking Buildbucket for the build status
[18:38:54.014] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:38:54.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:22:0) after 1m0s
[18:39:54.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:22:0)
[18:39:54.031] Timer tick, asking Buildbucket for the build status
[18:39:54.304] Build 8857291161701346976: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:39:54.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:23:0) after 1m0s
[18:40:31.662] Received PubSub notification, asking Buildbucket for the build status
[18:40:31.735] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:54.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:23:0)
[18:40:54.706] Timer tick, asking Buildbucket for the build status
[18:40:55.837] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:55.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:25:0) after 1m0s
[18:41:56.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:25:0)
[18:41:56.053] Timer tick, asking Buildbucket for the build status
[18:41:56.132] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:56.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:26:0) after 1m0s
[18:42:56.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:26:0)
[18:42:56.287] Timer tick, asking Buildbucket for the build status
[18:42:56.525] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:56.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:27:0) after 1m0s
[18:43:56.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:27:0)
[18:43:56.604] Timer tick, asking Buildbucket for the build status
[18:43:57.002] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:57.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:28:0) after 1m0s
[18:44:57.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:28:0)
[18:44:57.175] Timer tick, asking Buildbucket for the build status
[18:44:57.248] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:57.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:29:0) after 1m0s
[18:45:57.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:29:0)
[18:45:57.488] Timer tick, asking Buildbucket for the build status
[18:45:57.826] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:57.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:30:0) after 1m0s
[18:46:57.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:30:0)
[18:46:57.935] Timer tick, asking Buildbucket for the build status
[18:46:57.995] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:57.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:31:0) after 1m0s
[18:47:58.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:31:0)
[18:47:58.201] Timer tick, asking Buildbucket for the build status
[18:47:58.273] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:58.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:32:0) after 1m0s
[18:48:58.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:32:0)
[18:48:58.428] Timer tick, asking Buildbucket for the build status
[18:48:58.561] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:58.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:33:0) after 1m0s
[18:49:58.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:33:0)
[18:49:58.675] Timer tick, asking Buildbucket for the build status
[18:49:59.189] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:59.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:34:0) after 1m0s
[18:50:59.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:34:0)
[18:50:59.255] Timer tick, asking Buildbucket for the build status
[18:50:59.321] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:59.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:35:0) after 1m0s
[18:51:59.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:35:0)
[18:51:59.365] Timer tick, asking Buildbucket for the build status
[18:51:59.432] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:59.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:36:0) after 1m0s
[18:52:59.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:36:0)
[18:52:59.816] Timer tick, asking Buildbucket for the build status
[18:52:59.933] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:59.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:37:0) after 1m0s
[18:54:00.039] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:37:0)
[18:54:00.039] Timer tick, asking Buildbucket for the build status
[18:54:00.290] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:00.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:38:0) after 1m0s
[18:55:00.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:38:0)
[18:55:00.396] Timer tick, asking Buildbucket for the build status
[18:55:00.496] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:00.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:39:0) after 1m0s
[18:56:00.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:39:0)
[18:56:00.660] Timer tick, asking Buildbucket for the build status
[18:56:00.745] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:00.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:40:0) after 1m0s
[18:57:00.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:40:0)
[18:57:00.830] Timer tick, asking Buildbucket for the build status
[18:57:00.935] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:00.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:41:0) after 1m0s
[18:58:01.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:41:0)
[18:58:01.023] Timer tick, asking Buildbucket for the build status
[18:58:01.082] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:01.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:42:0) after 1m0s
[18:59:01.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:42:0)
[18:59:01.163] Timer tick, asking Buildbucket for the build status
[18:59:01.550] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:01.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:43:0) after 1m0s
[19:00:01.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:43:0)
[19:00:01.609] Timer tick, asking Buildbucket for the build status
[19:00:02.167] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:02.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:44:0) after 1m0s
[19:01:02.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:44:0)
[19:01:02.202] Timer tick, asking Buildbucket for the build status
[19:01:02.339] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:02.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:45:0) after 1m0s
[19:02:02.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:45:0)
[19:02:02.355] Timer tick, asking Buildbucket for the build status
[19:02:02.460] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:02.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:46:0) after 1m0s
[19:03:02.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:46:0)
[19:03:02.503] Timer tick, asking Buildbucket for the build status
[19:03:02.775] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:02.775] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:47:0) after 1m0s
[19:04:02.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:47:0)
[19:04:02.839] Timer tick, asking Buildbucket for the build status
[19:04:03.332] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:03.332] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:48:0) after 1m0s
[19:05:03.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:48:0)
[19:05:03.462] Timer tick, asking Buildbucket for the build status
[19:05:03.663] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:03.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:49:0) after 1m0s
[19:06:03.689] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:49:0)
[19:06:03.689] Timer tick, asking Buildbucket for the build status
[19:06:03.762] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:03.762] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:50:0) after 1m0s
[19:07:04.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:50:0)
[19:07:04.046] Timer tick, asking Buildbucket for the build status
[19:07:04.115] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:04.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:51:0) after 1m0s
[19:08:04.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:51:0)
[19:08:04.244] Timer tick, asking Buildbucket for the build status
[19:08:04.304] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:04.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:52:0) after 1m0s
[19:09:04.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:52:0)
[19:09:04.522] Timer tick, asking Buildbucket for the build status
[19:09:04.803] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:04.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:53:0) after 1m0s
[19:10:04.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:53:0)
[19:10:04.856] Timer tick, asking Buildbucket for the build status
[19:10:05.138] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:05.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:54:0) after 1m0s
[19:11:05.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:54:0)
[19:11:05.594] Timer tick, asking Buildbucket for the build status
[19:11:05.685] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:05.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:55:0) after 1m0s
[19:12:05.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:55:0)
[19:12:05.886] Timer tick, asking Buildbucket for the build status
[19:12:05.961] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:05.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:56:0) after 1m0s
[19:13:06.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:56:0)
[19:13:06.871] Timer tick, asking Buildbucket for the build status
[19:13:07.083] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:07.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:57:0) after 1m0s
[19:14:07.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:57:0)
[19:14:07.144] Timer tick, asking Buildbucket for the build status
[19:14:07.248] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:07.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:58:0) after 1m0s
[19:15:07.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:58:0)
[19:15:07.339] Timer tick, asking Buildbucket for the build status
[19:15:07.430] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:07.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:59:0) after 1m0s
[19:16:07.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:59:0)
[19:16:07.514] Timer tick, asking Buildbucket for the build status
[19:16:07.600] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:07.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:60:0) after 1m0s
[19:17:07.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:60:0)
[19:17:07.926] Timer tick, asking Buildbucket for the build status
[19:17:08.172] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:08.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:61:0) after 1m0s
[19:18:08.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:61:0)
[19:18:08.239] Timer tick, asking Buildbucket for the build status
[19:18:08.527] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:08.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:62:0) after 1m0s
[19:19:08.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:62:0)
[19:19:08.646] Timer tick, asking Buildbucket for the build status
[19:19:09.142] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:09.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:63:0) after 1m0s
[19:20:09.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:63:0)
[19:20:09.206] Timer tick, asking Buildbucket for the build status
[19:20:09.622] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:09.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:64:0) after 1m0s
[19:21:09.723] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:64:0)
[19:21:09.723] Timer tick, asking Buildbucket for the build status
[19:21:10.903] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:10.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:65:0) after 1m0s
[19:22:10.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:65:0)
[19:22:10.927] Timer tick, asking Buildbucket for the build status
[19:22:11.003] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:11.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:66:0) after 1m0s
[19:23:11.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:66:0)
[19:23:11.095] Timer tick, asking Buildbucket for the build status
[19:23:11.618] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:11.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:67:0) after 1m0s
[19:24:11.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:67:0)
[19:24:11.636] Timer tick, asking Buildbucket for the build status
[19:24:11.766] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:11.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:68:0) after 1m0s
[19:25:11.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:68:0)
[19:25:11.837] Timer tick, asking Buildbucket for the build status
[19:25:12.043] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:12.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:69:0) after 1m0s
[19:26:12.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:69:0)
[19:26:12.065] Timer tick, asking Buildbucket for the build status
[19:26:12.177] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:12.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:70:0) after 1m0s
[19:27:12.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:70:0)
[19:27:12.303] Timer tick, asking Buildbucket for the build status
[19:27:12.651] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:12.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:71:0) after 1m0s
[19:28:12.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:71:0)
[19:28:12.714] Timer tick, asking Buildbucket for the build status
[19:28:12.828] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:12.828] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:72:0) after 1m0s
[19:29:12.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:72:0)
[19:29:12.969] Timer tick, asking Buildbucket for the build status
[19:29:13.256] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:13.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:73:0) after 1m0s
[19:30:13.444] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:73:0)
[19:30:13.444] Timer tick, asking Buildbucket for the build status
[19:30:13.511] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:13.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:74:0) after 1m0s
[19:31:13.669] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:74:0)
[19:31:13.669] Timer tick, asking Buildbucket for the build status
[19:31:13.743] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:13.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:75:0) after 1m0s
[19:32:13.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:75:0)
[19:32:13.813] Timer tick, asking Buildbucket for the build status
[19:32:13.879] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:13.879] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:76:0) after 1m0s
[19:33:13.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:76:0)
[19:33:13.919] Timer tick, asking Buildbucket for the build status
[19:33:13.993] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:13.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:77:0) after 1m0s
[19:34:14.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:77:0)
[19:34:14.024] Timer tick, asking Buildbucket for the build status
[19:34:14.235] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:14.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:78:0) after 1m0s
[19:35:14.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:78:0)
[19:35:14.338] Timer tick, asking Buildbucket for the build status
[19:35:14.413] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:14.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:79:0) after 1m0s
[19:36:14.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:79:0)
[19:36:14.467] Timer tick, asking Buildbucket for the build status
[19:36:14.553] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:14.553] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:80:0) after 1m0s
[19:37:14.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:80:0)
[19:37:14.629] Timer tick, asking Buildbucket for the build status
[19:37:14.696] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:14.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:81:0) after 1m0s
[19:38:14.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:81:0)
[19:38:14.778] Timer tick, asking Buildbucket for the build status
[19:38:14.856] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:14.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:82:0) after 1m0s
[19:39:14.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:82:0)
[19:39:14.882] Timer tick, asking Buildbucket for the build status
[19:39:15.004] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:15.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:83:0) after 1m0s
[19:40:15.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:83:0)
[19:40:15.094] Timer tick, asking Buildbucket for the build status
[19:40:15.165] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:15.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:84:0) after 1m0s
[19:41:15.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:84:0)
[19:41:15.228] Timer tick, asking Buildbucket for the build status
[19:41:15.294] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:15.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:85:0) after 1m0s
[19:42:15.364] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:85:0)
[19:42:15.364] Timer tick, asking Buildbucket for the build status
[19:42:15.451] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:15.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:86:0) after 1m0s
[19:43:15.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:86:0)
[19:43:15.518] Timer tick, asking Buildbucket for the build status
[19:43:15.580] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:15.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:87:0) after 1m0s
[19:44:15.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:87:0)
[19:44:15.793] Timer tick, asking Buildbucket for the build status
[19:44:16.136] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:16.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:88:0) after 1m0s
[19:45:16.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:88:0)
[19:45:16.295] Timer tick, asking Buildbucket for the build status
[19:45:16.400] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:16.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:89:0) after 1m0s
[19:46:17.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:89:0)
[19:46:17.802] Timer tick, asking Buildbucket for the build status
[19:46:17.904] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:17.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:90:0) after 1m0s
[19:47:17.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:90:0)
[19:47:17.968] Timer tick, asking Buildbucket for the build status
[19:47:18.033] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:18.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:91:0) after 1m0s
[19:48:18.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:91:0)
[19:48:18.362] Timer tick, asking Buildbucket for the build status
[19:48:18.543] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:18.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:92:0) after 1m0s
[19:49:18.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:92:0)
[19:49:18.656] Timer tick, asking Buildbucket for the build status
[19:49:18.761] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:18.761] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:93:0) after 1m0s
[19:50:18.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:93:0)
[19:50:18.974] Timer tick, asking Buildbucket for the build status
[19:50:19.147] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:19.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:94:0) after 1m0s
[19:51:19.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:94:0)
[19:51:19.261] Timer tick, asking Buildbucket for the build status
[19:51:19.372] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:19.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:95:0) after 1m0s
[19:52:19.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:95:0)
[19:52:19.522] Timer tick, asking Buildbucket for the build status
[19:52:19.974] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:19.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:96:0) after 1m0s
[19:53:20.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:96:0)
[19:53:20.051] Timer tick, asking Buildbucket for the build status
[19:53:20.640] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:20.640] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:97:0) after 1m0s
[19:54:20.673] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:97:0)
[19:54:20.673] Timer tick, asking Buildbucket for the build status
[19:54:20.840] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:20.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:98:0) after 1m0s
[19:55:20.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:98:0)
[19:55:20.890] Timer tick, asking Buildbucket for the build status
[19:55:21.042] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:21.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:99:0) after 1m0s
[19:56:21.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:99:0)
[19:56:21.040] Timer tick, asking Buildbucket for the build status
[19:56:21.391] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:21.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:100:0) after 1m0s
[19:57:21.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:100:0)
[19:57:21.506] Timer tick, asking Buildbucket for the build status
[19:57:21.631] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:21.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:101:0) after 1m0s
[19:58:21.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:101:0)
[19:58:21.872] Timer tick, asking Buildbucket for the build status
[19:58:22.043] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:22.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:102:0) after 1m0s
[19:59:22.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:102:0)
[19:59:22.148] Timer tick, asking Buildbucket for the build status
[19:59:22.242] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:22.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:103:0) after 1m0s
[20:00:22.279] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:103:0)
[20:00:22.279] Timer tick, asking Buildbucket for the build status
[20:00:22.380] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:22.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:104:0) after 1m0s
[20:01:22.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:104:0)
[20:01:22.406] Timer tick, asking Buildbucket for the build status
[20:01:22.877] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:22.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:105:0) after 1m0s
[20:02:22.917] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:105:0)
[20:02:22.917] Timer tick, asking Buildbucket for the build status
[20:02:23.139] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:23.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:106:0) after 1m0s
[20:03:23.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:106:0)
[20:03:23.242] Timer tick, asking Buildbucket for the build status
[20:03:23.829] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:23.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:107:0) after 1m0s
[20:04:23.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:107:0)
[20:04:23.919] Timer tick, asking Buildbucket for the build status
[20:04:24.064] Build 8857291161701346976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:24.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9022721223721202688:108:0) after 1m0s
[20:04:31.272] Received PubSub notification, asking Buildbucket for the build status
[20:04:31.371] Build 8857291161701346976: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:04:31.371] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611432270035702",
"created_by": "project:chromium",
"created_ts": "1611425928361743",
"id": "8857291161701346976",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e1782a3a845dcf848153977055691ed109b6611c\"}}",
"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\": \"e1782a3a845dcf848153977055691ed109b6611c\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-6-hjj5\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 44850, \"got_angle_revision\": \"3c3b82abcf0a5c18b4d97ae49726045ce6d3b832\", \"got_dawn_revision\": \"f1f8394de04ea9532de763dfb2f968fc9610683b\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"e1782a3a845dcf848153977055691ed109b6611c\", \"got_revision_cp\": \"refs/heads/master@{#846526}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"413f7cb17c77c95e4cc3ba141f3c0f049ac2ecb2\", \"got_v8_revision\": \"f2b2f28304b332e59226ee6c0688307ed9982884\", \"got_v8_revision_cp\": \"refs/heads/9.0.57@{#1}\", \"got_webrtc_revision\": \"90776cb0ef72d437983c8d29e5a7f2ac264c107d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33064}\", \"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\": \"e1782a3a845dcf848153977055691ed109b6611c\", \"swarm_hashes_refs/heads/master(at){#846526}_without_patch\": {\"absl_hardening_tests\": \"dc8b38ebc42465c367c58e6d3e8de1108c0485ea\", \"accessibility_unittests\": \"b9ad57a3c4bc93a08fbb911db162846d78b75ff3\", \"angle_unittests\": \"150b62cd2bb404a34f8a3847addd087549785132\", \"app_list_unittests\": \"535e760f44c75b0408a137eae0390ff7894e0804\", \"app_shell_unittests\": \"2d614fc5309a379c945ca93e8927c3d24d8ce36d\", \"ash_unittests\": \"2b8e78ef75a4f6bd8180ac1a09416d22ccdaddf7\", \"aura_unittests\": \"88e3291cd80c418cf48967257c7f9b5cbb6fc5a0\", \"base_unittests\": \"ad61d12b62b807ed754ac21718f539363dec8040\", \"base_util_unittests\": \"1711cec61f972988ee4a3bc0a4fa5ba8f3a6254f\", \"blink_common_unittests\": \"a5ab29ecdac0103e966ca9fc1551aea879bfd799\", \"blink_fuzzer_unittests\": \"f68755bed112b02132d5c4cd90ebc5a2cb30fbcf\", \"blink_heap_unittests\": \"8f4a273d3e36200c8de2794845aa9955b2ebf966\", \"blink_platform_unittests\": \"f0b73cf2b7a6856529bd93be980ea279f8b91dcb\", \"blink_unittests\": \"453020793d6bdae94d607c8f17a9e03d2a7e1ab8\", \"boringssl_crypto_tests\": \"abb21a9d81ef53bf0aa894159ec6c993d37d86c5\", \"boringssl_ssl_tests\": \"893eaaf4e8dbe8dc13ffca109d8c377487c21d4b\", \"browser_tests\": \"87c93746dbd2b9c27cb9aef02a8c5df33a457741\", \"capture_unittests\": \"0adcc6eeb222e56672dadad18381d822997081e5\", \"cast_unittests\": \"7e076a49e77cc659e00b077daf3697c9379080bd\", \"cc_unittests\": \"8689f47f7e434bbe5c5ed2842bf3e031f65b5179\", \"chrome_app_unittests\": \"0a1edc304177485e85fd525375a157d5683ad359\", \"chromedriver_unittests\": \"fb9ef5825d516db56b92063edf5bc516bab9a68b\", \"chromeos_components_unittests\": \"7b8bc05c39ecfb8ecc4351bf3caba0d6eea3d588\", \"chromeos_unittests\": \"4845962cc17559acdf799880d6f66334fd2dfd04\", \"components_browsertests\": \"4eb25967edea144a18d249044814c3f876dac3a4\", \"components_unittests\": \"03aad9ec0ea503c5115ce7e7c2d0915b18f98ae9\", \"compositor_unittests\": \"82aeaa2a36771677bb682be0e6c6d8a1c1eb8196\", \"content_browsertests\": \"7810c2fd8da5c21808fb61cf1938ebe5cbdb48a8\", \"content_unittests\": \"3a3bf6b0e3af9828f070644d7c7efb5439806763\", \"crashpad_tests\": \"9b0ec78c8de3edbf9854f1759e7d6f0aa43016e2\", \"crypto_unittests\": \"d1924de36263a039e18e935829cd5e9b67652807\", \"dbus_unittests\": \"dad2c97c0f50008c7bfcc704b4a207e35b5ad83e\", \"device_unittests\": \"0a88452b5346f6b468faf7a0c07edd31b409a1ef\", \"display_unittests\": \"3a65532af0783629e2caa2588c57d7ca1506052f\", \"events_unittests\": \"d1df346bc136fe0c0f586a5ed14b341bf58f8879\", \"exo_unittests\": \"49fd291edc9c2eef69115d7ed06c3a30326767a6\", \"extensions_browsertests\": \"010c2520e2448aec8176b9eb326903f9e7a8332b\", \"extensions_unittests\": \"92d577ce3fbeb219a7c01d357e85973a82879fb9\", \"filesystem_service_unittests\": \"f3645f858beab7608ca334ff15b113cf9e9b42e8\", \"gcm_unit_tests\": \"de5e461d83db0f644a819ab8828254798d8bac6d\", \"gfx_unittests\": \"c5320e950e877baf8d7ae1d123ad4b8f39dffb0c\", \"gin_unittests\": \"d2e5afbe6176c203345d4ca09d431e5b91d3baba\", \"gl_unittests_ozone\": \"96a4edad1486f0fce22a39113b32d1668b47e207\", \"google_apis_unittests\": \"fa69fab7cab0c000ea2ad35cb0de44d4e28025de\", \"gpu_unittests\": \"875419767edfb3fd44ec825a19f5e1490d376bc9\", \"gwp_asan_unittests\": \"f1be1054495054629e5b1666c62451b9efd14910\", \"interactive_ui_tests\": \"3779e813b838a6dcc35bf6a1d05f3f752352dcf4\", \"ipc_tests\": \"17177319d58a31df42cfe2c44ed8a99a3bdc4b56\", \"jingle_unittests\": \"c6a702f1a6fc0da5a00d87a9bbe2ceebf9847d97\", \"keyboard_unittests\": \"7972fd46d3d740e9de870698caad94616a7b819f\", \"latency_unittests\": \"344bc5028fa0ffbb6374b17540575f3c464b6b3d\", \"libjingle_xmpp_unittests\": \"f92be00472da8c5bb4dcd6e8b46e7a9124ad8c30\", \"liburlpattern_unittests\": \"ebbcdd83367f4cc4f1ee0c8590d0f132f678d58a\", \"media_blink_unittests\": \"253da74cdd9fc5951eac7a06670fa88d47c550f3\", \"media_unittests\": \"5978fd9c267a0e22856dde6acadcb2ada885b9e0\", \"message_center_unittests\": \"1ade69c060a513342581d6d4dfcd75bff3374404\", \"midi_unittests\": \"00c270958fb03755e27064786c3f2f65cd82ee1e\", \"mojo_core_unittests\": \"072efe9d4d0051115acbb7e59472dd8bac1422f2\", \"mojo_unittests\": \"3447a6522ea38b0682a25ab481583401e3ee64b4\", \"nacl_helper_nonsfi_unittests\": \"1c91a45e57519f253e3e0eaa82fc0a196a74723f\", \"nacl_loader_unittests\": \"421ce6be46972ea4e62b6e2a39381962b49c086d\", \"native_theme_unittests\": \"ca189c62c123fde628312a1f8904546e5f74911f\", \"net_unittests\": \"6c1514a870fe08884ead4e8500197b6f4daa9e0d\", \"ozone_gl_unittests\": \"ecc901b29a0d37a353a23f0248945c3e4c4f8b34\", \"ozone_unittests\": \"563f9e5f10b992ec3e095361aff067b1f0d8c12e\", \"ozone_x11_unittests\": \"eaafc7a488d2318c7d047b4f7a5fe1a36264daba\", \"pdf_unittests\": \"45c6102694c0fcd123f95be8f68aecc16ef91d78\", \"perfetto_unittests\": \"311368dea8fc25a2a337142adb8dd3fdf3fc8e26\", \"ppapi_unittests\": \"ad54a3978842658f3803ed79c31a71db612b43b3\", \"printing_unittests\": \"77d561d6b3276eda97ed3b2be4834beb9b9549eb\", \"remoting_unittests\": \"da4e883cb30dcc01ebe755ee4d2967dc2b109070\", \"sandbox_linux_unittests\": \"c753f31b215c943850c9af3838cacfb82cc24135\", \"service_manager_unittests\": \"7c7b4aa12d84dfd12806df3777ba3f7318f8085f\", \"services_unittests\": \"0a2d5e5e8d4078eb03ff4ee080d16acab2654062\", \"shell_dialogs_unittests\": \"4a0ead8303b89ef018908fe0111ef31266ea0bd4\", \"shell_encryption_unittests\": \"5c6e7d145dcaf0909beb772831a165eb19f4301c\", \"skia_unittests\": \"96b2f030d54b4acbe4cee0d094f50a45ff4ff421\", \"snapshot_unittests\": \"4a434a85d6375b36553beaceec8a5f0e46697c2a\", \"sql_unittests\": \"51b5c2ab9ad5fa676ca57ffc7a6fdea2b6eda0b7\", \"storage_unittests\": \"0c94469fb7b12cd171f3c4c2401f9dc396cebe90\", \"sync_integration_tests\": \"2f806512a37209196258b026f3ccfda2a505921c\", \"traffic_annotation_auditor_unittests\": \"ff1512bf511fad188e762ec6e9468afb44720824\", \"ui_base_unittests\": \"b1ef846e70f7046f8472aa840333625292b252b1\", \"ui_chromeos_unittests\": \"bfa3d2a96ae0fe98c89daa84da14f5552ffb4680\", \"ui_touch_selection_unittests\": \"2ea6568f28a1c18cf8b09b6b0d139f5ea64e52c1\", \"unit_tests\": \"595fd781eaea6dea535a18bd6b9f2b5b1168133f\", \"url_unittests\": \"548723fc2aa32fe271c926ecca3d206a846c84cc\", \"usage_time_limit_unittests\": \"1d811a801c90e4bedbc5d6da943659ef3113f8a0\", \"views_unittests\": \"d4d1b062d9062f21a7c0f64c7ec1c3950701afab\", \"viz_unittests\": \"0f94f21c1042bed3b376c5d5c6943d05553a0387\", \"wayland_client_perftests\": \"b31f5e8ab73dc720bf891f8741cf5dde2ca67b0f\", \"wm_unittests\": \"28cfd4fe58cb31e74685c6b2ab2057b489230875\", \"wtf_unittests\": \"5847b5a1f333bd7c6d1d84ded9f872d27708ba1d\", \"zlib_unittests\": \"f294d5f47ce4afba382588c892ea0fa6666a16e0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_06f1ed350fecda52f561db3eb00cb39e105b14f5c02d94078111c7babc8da8c6_v2\", \"builder_8e7ad9a10a7772feba5b42dda56992e918fe88f23579c3ddaf696dde66ee4238_v2\", \"builder_c6f1473df00e57847ed4ff0f74718f3dfb2a5d42012d3d3fe6b396b4c9a29f62_v2\", \"builder_e7fd4b7a9e211f8d968af60263c508e13e49814167aff980c2bf239c05ea48ef_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-6-hjj5\"], \"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-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611427229686274",
"status": "COMPLETED",
"status_changed_ts": "1611432270323879",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/44850",
"builder:linux-chromeos-rel",
"buildset:commit/git/e1782a3a845dcf848153977055691ed109b6611c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e1782a3a845dcf848153977055691ed109b6611c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022721223721202688",
"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/8857291161701346976/+/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:514949df898bb910",
"user_agent:luci-scheduler"
],
"updated_ts": "1611432270333642",
"url": "https://ci.chromium.org/b/8857291161701346976",
"utcnow_ts": "1611432271359281"
}
}
[20:04:31.371] Invocation finished in 1h45m44.320058073s with status SUCCEEDED