[17:10:46.041] New invocation is queued and will start shortly
[17:10:47.458] Starting the invocation (attempt 1)
[17:10:47.503] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:10:47.503] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:10:47.503] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021185354566378496",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"abcd08ac000549f0ec74486a6737743931f554e2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9021185354566378496",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/abcd08ac000549f0ec74486a6737743931f554e2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/abcd08ac000549f0ec74486a6737743931f554e2",
"gitiles_ref:refs/heads/master"
]
}
[17:10:48.119] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612890647595185",
"id": "8855755292265920464",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"abcd08ac000549f0ec74486a6737743931f554e2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612890648008758",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45278",
"builder:linux-chromeos-rel",
"buildset:commit/git/abcd08ac000549f0ec74486a6737743931f554e2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/abcd08ac000549f0ec74486a6737743931f554e2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021185354566378496",
"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/8855755292265920464/+/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": "1612890648008875",
"url": "https://ci.chromium.org/b/8855755292265920464",
"utcnow_ts": "1612890648111342"
}
}
[17:10:48.119] Task URL: https://ci.chromium.org/b/8855755292265920464
[17:10:48.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:2:0) after 1m0s
[17:11:08.250] Received PubSub notification, asking Buildbucket for the build status
[17:11:08.319] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:48.173] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:2:0)
[17:11:48.173] Timer tick, asking Buildbucket for the build status
[17:11:48.339] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:48.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:4:0) after 1m0s
[17:12:48.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:4:0)
[17:12:48.361] Timer tick, asking Buildbucket for the build status
[17:12:48.458] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:48.458] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:5:0) after 1m0s
[17:13:48.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:5:0)
[17:13:48.480] Timer tick, asking Buildbucket for the build status
[17:13:48.566] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:48.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:6:0) after 1m0s
[17:14:48.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:6:0)
[17:14:48.614] Timer tick, asking Buildbucket for the build status
[17:14:48.795] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:48.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:7:0) after 1m0s
[17:15:48.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:7:0)
[17:15:48.771] Timer tick, asking Buildbucket for the build status
[17:15:48.906] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:48.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:8:0) after 1m0s
[17:16:48.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:8:0)
[17:16:48.945] Timer tick, asking Buildbucket for the build status
[17:16:49.044] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:49.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:9:0) after 1m0s
[17:17:49.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:9:0)
[17:17:49.182] Timer tick, asking Buildbucket for the build status
[17:17:49.432] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:49.432] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:10:0) after 1m0s
[17:18:49.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:10:0)
[17:18:49.519] Timer tick, asking Buildbucket for the build status
[17:18:49.598] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:49.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:11:0) after 1m0s
[17:19:49.705] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:11:0)
[17:19:49.705] Timer tick, asking Buildbucket for the build status
[17:19:49.920] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:49.920] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:12:0) after 1m0s
[17:20:49.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:12:0)
[17:20:49.997] Timer tick, asking Buildbucket for the build status
[17:20:50.469] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:50.469] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:13:0) after 1m0s
[17:21:50.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:13:0)
[17:21:50.507] Timer tick, asking Buildbucket for the build status
[17:21:50.622] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:50.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:14:0) after 1m0s
[17:22:50.734] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:14:0)
[17:22:50.734] Timer tick, asking Buildbucket for the build status
[17:22:51.195] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:51.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:15:0) after 1m0s
[17:23:51.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:15:0)
[17:23:51.308] Timer tick, asking Buildbucket for the build status
[17:23:51.389] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:51.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:16:0) after 1m0s
[17:24:51.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:16:0)
[17:24:51.537] Timer tick, asking Buildbucket for the build status
[17:24:51.818] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:51.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:17:0) after 1m0s
[17:25:51.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:17:0)
[17:25:51.884] Timer tick, asking Buildbucket for the build status
[17:25:56.477] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:56.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:18:0) after 1m0s
[17:26:56.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:18:0)
[17:26:56.515] Timer tick, asking Buildbucket for the build status
[17:27:00.500] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:00.500] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:19:0) after 1m0s
[17:28:00.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:19:0)
[17:28:00.615] Timer tick, asking Buildbucket for the build status
[17:28:00.842] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:00.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:20:0) after 1m0s
[17:29:00.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:20:0)
[17:29:00.903] Timer tick, asking Buildbucket for the build status
[17:29:00.965] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:00.965] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:21:0) after 1m0s
[17:30:01.033] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:21:0)
[17:30:01.033] Timer tick, asking Buildbucket for the build status
[17:30:01.138] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:01.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:22:0) after 1m0s
[17:31:01.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:22:0)
[17:31:01.227] Timer tick, asking Buildbucket for the build status
[17:31:01.356] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:01.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:23:0) after 1m0s
[17:32:01.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:23:0)
[17:32:01.441] Timer tick, asking Buildbucket for the build status
[17:32:01.644] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:01.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:24:0) after 1m0s
[17:33:01.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:24:0)
[17:33:01.800] Timer tick, asking Buildbucket for the build status
[17:33:01.870] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:01.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:25:0) after 1m0s
[17:34:01.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:25:0)
[17:34:01.937] Timer tick, asking Buildbucket for the build status
[17:34:02.006] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:02.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:26:0) after 1m0s
[17:35:02.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:26:0)
[17:35:02.074] Timer tick, asking Buildbucket for the build status
[17:35:02.154] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:02.154] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:27:0) after 1m0s
[17:36:02.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:27:0)
[17:36:02.245] Timer tick, asking Buildbucket for the build status
[17:36:02.376] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:02.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:28:0) after 1m0s
[17:37:02.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:28:0)
[17:37:02.486] Timer tick, asking Buildbucket for the build status
[17:37:02.580] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:02.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:29:0) after 1m0s
[17:38:02.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:29:0)
[17:38:02.589] Timer tick, asking Buildbucket for the build status
[17:38:02.651] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:02.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:30:0) after 1m0s
[17:39:02.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:30:0)
[17:39:02.738] Timer tick, asking Buildbucket for the build status
[17:39:02.827] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:02.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:31:0) after 1m0s
[17:40:02.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:31:0)
[17:40:02.878] Timer tick, asking Buildbucket for the build status
[17:40:02.936] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:02.936] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:32:0) after 1m0s
[17:41:03.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:32:0)
[17:41:03.001] Timer tick, asking Buildbucket for the build status
[17:41:03.160] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:03.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:33:0) after 1m0s
[17:42:03.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:33:0)
[17:42:03.252] Timer tick, asking Buildbucket for the build status
[17:42:03.353] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:03.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:34:0) after 1m0s
[17:43:03.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:34:0)
[17:43:03.432] Timer tick, asking Buildbucket for the build status
[17:43:03.526] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:03.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:35:0) after 1m0s
[17:44:03.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:35:0)
[17:44:03.612] Timer tick, asking Buildbucket for the build status
[17:44:03.865] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:03.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:36:0) after 1m0s
[17:45:04.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:36:0)
[17:45:04.054] Timer tick, asking Buildbucket for the build status
[17:45:04.131] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:04.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:37:0) after 1m0s
[17:46:04.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:37:0)
[17:46:04.307] Timer tick, asking Buildbucket for the build status
[17:46:04.413] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:04.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:38:0) after 1m0s
[17:47:04.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:38:0)
[17:47:04.492] Timer tick, asking Buildbucket for the build status
[17:47:04.825] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:04.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:39:0) after 1m0s
[17:48:04.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:39:0)
[17:48:04.909] Timer tick, asking Buildbucket for the build status
[17:48:05.038] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:05.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:40:0) after 1m0s
[17:49:05.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:40:0)
[17:49:05.095] Timer tick, asking Buildbucket for the build status
[17:49:05.162] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:05.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:41:0) after 1m0s
[17:50:05.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:41:0)
[17:50:05.200] Timer tick, asking Buildbucket for the build status
[17:50:05.299] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:05.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:42:0) after 1m0s
[17:51:05.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:42:0)
[17:51:05.351] Timer tick, asking Buildbucket for the build status
[17:51:05.459] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:05.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:43:0) after 1m0s
[17:52:05.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:43:0)
[17:52:05.523] Timer tick, asking Buildbucket for the build status
[17:52:05.622] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:05.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:44:0) after 1m0s
[17:53:05.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:44:0)
[17:53:05.745] Timer tick, asking Buildbucket for the build status
[17:53:05.909] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:05.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:45:0) after 1m0s
[17:54:06.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:45:0)
[17:54:06.024] Timer tick, asking Buildbucket for the build status
[17:54:06.140] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:06.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:46:0) after 1m0s
[17:55:06.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:46:0)
[17:55:06.204] Timer tick, asking Buildbucket for the build status
[17:55:06.440] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:06.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:47:0) after 1m0s
[17:56:06.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:47:0)
[17:56:06.520] Timer tick, asking Buildbucket for the build status
[17:56:06.703] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:06.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:48:0) after 1m0s
[17:57:06.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:48:0)
[17:57:06.802] Timer tick, asking Buildbucket for the build status
[17:57:06.899] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:06.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:49:0) after 1m0s
[17:58:06.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:49:0)
[17:58:06.972] Timer tick, asking Buildbucket for the build status
[17:58:07.443] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:07.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:50:0) after 1m0s
[17:59:07.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:50:0)
[17:59:07.527] Timer tick, asking Buildbucket for the build status
[17:59:07.848] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:07.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:51:0) after 1m0s
[18:00:07.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:51:0)
[18:00:07.920] Timer tick, asking Buildbucket for the build status
[18:00:08.031] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:08.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:52:0) after 1m0s
[18:01:08.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:52:0)
[18:01:08.294] Timer tick, asking Buildbucket for the build status
[18:01:08.422] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:08.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:53:0) after 1m0s
[18:02:08.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:53:0)
[18:02:08.523] Timer tick, asking Buildbucket for the build status
[18:02:08.676] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:08.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:54:0) after 1m0s
[18:03:08.779] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:54:0)
[18:03:08.779] Timer tick, asking Buildbucket for the build status
[18:03:08.954] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:08.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:55:0) after 1m0s
[18:04:08.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:55:0)
[18:04:08.998] Timer tick, asking Buildbucket for the build status
[18:04:09.944] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:09.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:56:0) after 1m0s
[18:05:10.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:56:0)
[18:05:10.032] Timer tick, asking Buildbucket for the build status
[18:05:10.164] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:10.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:57:0) after 1m0s
[18:06:10.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:57:0)
[18:06:10.216] Timer tick, asking Buildbucket for the build status
[18:06:11.551] Build 8855755292265920464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:11.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9021185354566378496:58:0) after 1m0s
[18:06:12.290] Received PubSub notification, asking Buildbucket for the build status
[18:06:12.854] Build 8855755292265920464: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:06:12.854] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612893970281148",
"created_by": "project:chromium",
"created_ts": "1612890647595185",
"id": "8855755292265920464",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"abcd08ac000549f0ec74486a6737743931f554e2\"}}",
"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\": \"abcd08ac000549f0ec74486a6737743931f554e2\", \"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-162-831p\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 45278, \"got_angle_revision\": \"b7d441e662a1839b941b1ddd6ca04f68aecfbabc\", \"got_dawn_revision\": \"2831f0584028114a8896059ce00e7bddaf3bba1f\", \"got_nacl_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"got_revision\": \"abcd08ac000549f0ec74486a6737743931f554e2\", \"got_revision_cp\": \"refs/heads/master@{#852227}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"9d35d544ce966098fdcb36107835d57a4dc1f32d\", \"got_v8_revision\": \"3da71e5e39df4bd049bfe2576033cbcbca8f3aa8\", \"got_v8_revision_cp\": \"refs/heads/9.0.145@{#1}\", \"got_webrtc_revision\": \"54ea85c2cd3a2cb1b8f440a71aa9676a9b88135c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33190}\", \"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\": \"abcd08ac000549f0ec74486a6737743931f554e2\", \"swarm_hashes_refs/heads/master(at){#852227}_without_patch\": {\"absl_hardening_tests\": \"edbb6c4f51f23dc720e766c8706d0acdec13f0eb\", \"accessibility_unittests\": \"6a5fd3ef858a033e71259390940c4a30f09e839a\", \"angle_unittests\": \"fa89c77831e47d33d55e1eee310b3a49b7a867c3\", \"app_list_unittests\": \"64f5b9708b35b128bc01779f48e0cb3fad30f09b\", \"app_shell_unittests\": \"3adfeb714b07802b8ec6fd509beb42ba5ce14419\", \"ash_unittests\": \"71e3aafac59b32d56187ac479cac1ba0acae3816\", \"aura_unittests\": \"c40cb2f9c62025b2bd4ffefd8b8621148d3e3f59\", \"base_unittests\": \"ddb151a0c00eb3dbfc0536b122b3d3db6e651a52\", \"base_util_unittests\": \"42f2c0145df79ad5afc8a46dc940ab546b88ecf3\", \"blink_common_unittests\": \"460d299aa2dfc1a4dc52b1d54a02511164c3490b\", \"blink_fuzzer_unittests\": \"e7286ea173e8884e247d4d8f02ef7a5a53bcc1f0\", \"blink_heap_unittests\": \"bfcb552aae162613e970f595699d8fb978ac3649\", \"blink_platform_unittests\": \"bc85cb830d979af2038fa870f5f51a54fcd0dbcf\", \"blink_unittests\": \"28223a7fe929f8b47d0a40ebeb03a3cda4b21bc6\", \"boringssl_crypto_tests\": \"94bd5df04a7523f99beb739f64b20119a4dacafd\", \"boringssl_ssl_tests\": \"41075a075a8ccb9ab17c806a1618bfee735e4b10\", \"browser_tests\": \"a494ec2b0c085166519a0724310971c0411c1e80\", \"capture_unittests\": \"659f1af310b00ea23dd1cc78a788b2d3c79f11e4\", \"cast_unittests\": \"21484ea6d0f57a4a83e6bfae2bace73a1c747bd0\", \"cc_unittests\": \"f359965288b003ca9d60e13b783407e7c4182f46\", \"chrome_app_unittests\": \"1103b850e99922adec6245359e53ab93c21ae16a\", \"chromedriver_unittests\": \"6b52957a8526e5f2e94d6b4ea165f670a27b3461\", \"chromeos_components_unittests\": \"1a8dc1e3c6d497034ab04ac8da741e03c55edb18\", \"chromeos_unittests\": \"dec09c9ce7e55da7c9e48fa698a8037b69f71f5e\", \"components_browsertests\": \"c3e7dea1110135a75fc33f23e22fccb419d1a6e1\", \"components_unittests\": \"4ab9fa3ed69f70f4a627081e8284591a62f5623b\", \"compositor_unittests\": \"c92d124db8e786db7c19a46bb67dc64c2d39d7d6\", \"content_browsertests\": \"98eacc63c7c6b8d633d894d6ee83d239284faa4d\", \"content_unittests\": \"5d8847ee0777d5c161b5716eead44ddeb37d0efb\", \"crashpad_tests\": \"7fc5bdbfed46725946ab43a13e4db054eace4982\", \"crypto_unittests\": \"3efb9c3be01a66f1d8fe76dde43d5e8bc060fbe8\", \"dbus_unittests\": \"5ba7085a629cfc94ba08b169a03445d092147d1d\", \"device_unittests\": \"f45645a3d2e8d9676b6a2dc370ad17a5e6b3ee78\", \"display_unittests\": \"163803da9864b48cfdcd3791a32569cca06db947\", \"events_unittests\": \"4d46246ee756aa1aeb11ef3c6c95ca24ae8866e0\", \"exo_unittests\": \"32ef3a37ff9a9f1a0c6fa9514a72e7b3c32fcff9\", \"extensions_browsertests\": \"42d82a2b945f055e1153e56e6a3cbd03ff85b1e2\", \"extensions_unittests\": \"1b4b310539b0ed80ed8c448b84a3a2fdf606ff4b\", \"filesystem_service_unittests\": \"d450f387c50ac02ed85b938941f415c3c98106f3\", \"gcm_unit_tests\": \"7fb8dfa58b7ee3ba7c9ca43ff397b71a617ec288\", \"gfx_unittests\": \"612e938bc3a39ff356da812fac9e9931d5e121dd\", \"gin_unittests\": \"52458075f5a5a54e7e3da39fe16e2cfa626b3f45\", \"gl_unittests_ozone\": \"bf4c62865cae244c6c1749f2703e64aabe933f4e\", \"google_apis_unittests\": \"6b7f5b667e8bddaa0ad395c4e14b1773570e8a85\", \"gpu_unittests\": \"63166b061ebf9b828660492ef586757e993df2d4\", \"gwp_asan_unittests\": \"0187c87d3d943e7071aae5907c46b1ee3e243cd5\", \"interactive_ui_tests\": \"6c3d8b2d202d386f420854aba9d1eff7590c08a3\", \"ipc_tests\": \"06704ccecaab638bd8abfd8ad05b031928d9a1a9\", \"jingle_unittests\": \"0d77a4be804d6ee3f70cafdbfab4078f02062c04\", \"keyboard_unittests\": \"991fbef2acdbdb19fb3e34cdd967bd7fbe726bb4\", \"latency_unittests\": \"415c354464f7a056b5b6c071c5bec3e16da3e7f3\", \"libjingle_xmpp_unittests\": \"6d7f5fb2ba4eeeb18f3c287f5a844d96db20bdc9\", \"liburlpattern_unittests\": \"3add93d88e2c6163a3e0c1382721ff7374f1868b\", \"media_blink_unittests\": \"6598bdb5025d490ad1b53e19f2d24662a4ef8a20\", \"media_unittests\": \"3afaa4666ea93c361279f9526809ffac74314a0d\", \"message_center_unittests\": \"90ef4872684313fea4a57e0cf466ceb340a0661c\", \"midi_unittests\": \"c844900b9d18ec047161e8e17803d57bb5ac4dc2\", \"mojo_core_unittests\": \"2c4db2959605700f11e22f54c944dbcec2a0e01a\", \"mojo_unittests\": \"55653bbe54de76bbafb5fbbe5c2ffbfd3382ceb6\", \"nacl_helper_nonsfi_unittests\": \"b4c1f7ab6446be2efabbb3049ff8aa9ec4b08b5c\", \"nacl_loader_unittests\": \"56cdbb85654c2ba9d674cec32fb02d14520975d5\", \"native_theme_unittests\": \"043610a9e33d8038b2f6214a841c5c1ad767e7e4\", \"net_unittests\": \"7efff3886671dfcb1e55edd0b34de089ec3ddcb4\", \"ozone_gl_unittests\": \"e44ae38c8b968e3081b9d2c0d1863c99a679cd41\", \"ozone_unittests\": \"5d08dc377fe72cc46b67581ebc7618d9d77bbed2\", \"ozone_x11_unittests\": \"c9e14f50ea95aa5344c6a72bc4bf78c0e1fbc4eb\", \"pdf_unittests\": \"46048064e92dca4486999fb6b17688fc6da03b4b\", \"perfetto_unittests\": \"1e931463cbfb8b9467ca268f672daa7c05ed2f69\", \"ppapi_unittests\": \"3b9fbe0685251436b4ed472a4fd88333e6252340\", \"printing_unittests\": \"61a86dad0035ea9ff5cb13f524d8d93318920f96\", \"remoting_unittests\": \"d9d0b3c2f7836b20eb0359720f51b6dd2e57b0dc\", \"sandbox_linux_unittests\": \"45f60cd460be4a5f80fa6beb0b0a85954d9635e5\", \"service_manager_unittests\": \"6cd7b6e7e0b4734bdcb07e6decbad3dfcafc4f16\", \"services_unittests\": \"2a63ed1c59b526ba8c4bb9c3c189b26fe66321d4\", \"shell_dialogs_unittests\": \"cb627574f8f411b2cb333db8f575f92935b2332b\", \"shell_encryption_unittests\": \"d5dca1e05d34605f740b3b578bebeb937ce6c158\", \"skia_unittests\": \"25a7fec67a80e388a7bdd37dde48f489eabfcd5d\", \"snapshot_unittests\": \"01f1a42f51d4590c996625dd5eda73f00081a93d\", \"sql_unittests\": \"cc6b212aeb1a5641757ccdc2bd8fed0624f4a8c3\", \"storage_unittests\": \"7bcf28a05587dc234f8e3abf9ae34fbed2993df6\", \"sync_integration_tests\": \"1a37679d47217affa30c8d1cabcf35b7582f1313\", \"traffic_annotation_auditor_unittests\": \"3857b69b7dece98d82fa92b35f4ea02693bbb445\", \"ui_base_unittests\": \"1fadb69b040ea96b4a78cea4fb0ffd84c745f4dd\", \"ui_chromeos_unittests\": \"4bb6dc67284c2035e54c6d7bcd476b6ad1b6e9f0\", \"ui_touch_selection_unittests\": \"370e815c4f67660b6958cdcde4981ddef95332b4\", \"unit_tests\": \"efd60c16491453c719ba2a4926e4322217d9f761\", \"url_unittests\": \"61b95616308412e1251dab4a7ee00189e3d6d8fe\", \"usage_time_limit_unittests\": \"e671a2c7c2eea753b23e3532f1ee9eac791cdab8\", \"views_unittests\": \"3f4709c2c7361fb8ce993d3eff491c6b430cae72\", \"viz_unittests\": \"f22ccfcfb71516418c376ac76a86c7e7b3155cad\", \"wayland_client_perftests\": \"9b6a79c99c302ea60b0ce1e296a16669dc1f1ef4\", \"wm_unittests\": \"da30d8b57bd527e85d6553bcbc34c98a04545198\", \"wtf_unittests\": \"29ed7aeb84769334c7baf7285f6a2d29a9c7a681\", \"zlib_unittests\": \"c534e7d2455e75bd7390e30404fce1e830a2c1b9\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_678d8b556ed6d2ea4aa43b80debb7b547a1d6d4433ddff28e80ab170912c760d_v2\", \"builder_6ab0eeab06ceac077c4f5e67fdebd04a4013e6231a211afb401025a2c2ae11ff_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_a15c792d02d243f2865d956ab51326d361a8fcfed3c44b30d209df7676d4718c_v2\", \"builder_bcc6b3e5c0858529730294da730af8ea17f2c5c79b8b0dc7af4e722a8412ac73_v2\", \"builder_d7cc7c59327c05146a034898ae78722818cd22c61c9435c4c4348e98bea5a132_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-162-831p\"], \"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\": [\"5685-1877293\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612890667490050",
"status": "COMPLETED",
"status_changed_ts": "1612893970730966",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/45278",
"builder:linux-chromeos-rel",
"buildset:commit/git/abcd08ac000549f0ec74486a6737743931f554e2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/abcd08ac000549f0ec74486a6737743931f554e2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021185354566378496",
"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/8855755292265920464/+/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:51a097b782003310",
"user_agent:luci-scheduler"
],
"updated_ts": "1612893970754549",
"url": "https://ci.chromium.org/b/8855755292265920464",
"utcnow_ts": "1612893972839297"
}
}
[18:06:12.854] Invocation finished in 55m26.83710266s with status SUCCEEDED