[02:59:57.647] New invocation is queued and will start shortly
[02:59:58.793] Starting the invocation (attempt 1)
[02:59:58.830] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:59:58.831] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:59:58.831] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9029211415722915728",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dd5b863bad31837551a992bf81edc3efc8981020\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9029211415722915728",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/dd5b863bad31837551a992bf81edc3efc8981020",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd5b863bad31837551a992bf81edc3efc8981020",
"gitiles_ref:refs/heads/master"
]
}
[02:59:59.494] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605236398931007",
"id": "8863781353712834176",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dd5b863bad31837551a992bf81edc3efc8981020\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605236399342789",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42824",
"builder:linux-chromeos-rel",
"buildset:commit/git/dd5b863bad31837551a992bf81edc3efc8981020",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd5b863bad31837551a992bf81edc3efc8981020",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029211415722915728",
"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/8863781353712834176/+/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": "1605236399342898",
"url": "https://ci.chromium.org/b/8863781353712834176",
"utcnow_ts": "1605236399483736"
}
}
[02:59:59.494] Task URL: https://ci.chromium.org/b/8863781353712834176
[02:59:59.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:2:0) after 1m0s
[03:01:00.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:2:0)
[03:01:00.412] Timer tick, asking Buildbucket for the build status
[03:01:00.766] Build 8863781353712834176: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:00.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:3:0) after 1m0s
[03:01:03.605] Received PubSub notification, asking Buildbucket for the build status
[03:01:03.899] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:02.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:3:0)
[03:02:02.094] Timer tick, asking Buildbucket for the build status
[03:02:02.223] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:02.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:5:0) after 1m0s
[03:03:03.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:5:0)
[03:03:03.262] Timer tick, asking Buildbucket for the build status
[03:03:03.631] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:03.631] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:6:0) after 1m0s
[03:04:03.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:6:0)
[03:04:03.762] Timer tick, asking Buildbucket for the build status
[03:04:03.897] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:03.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:7:0) after 1m0s
[03:05:04.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:7:0)
[03:05:04.011] Timer tick, asking Buildbucket for the build status
[03:05:04.481] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:04.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:8:0) after 1m0s
[03:06:04.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:8:0)
[03:06:04.532] Timer tick, asking Buildbucket for the build status
[03:06:04.655] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:04.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:9:0) after 1m0s
[03:07:04.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:9:0)
[03:07:04.698] Timer tick, asking Buildbucket for the build status
[03:07:05.182] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:05.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:10:0) after 1m0s
[03:08:05.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:10:0)
[03:08:05.192] Timer tick, asking Buildbucket for the build status
[03:08:05.578] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:05.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:11:0) after 1m0s
[03:09:05.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:11:0)
[03:09:05.653] Timer tick, asking Buildbucket for the build status
[03:09:05.717] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:05.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:12:0) after 1m0s
[03:10:05.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:12:0)
[03:10:05.724] Timer tick, asking Buildbucket for the build status
[03:10:05.818] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:05.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:13:0) after 1m0s
[03:11:05.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:13:0)
[03:11:05.986] Timer tick, asking Buildbucket for the build status
[03:11:06.261] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:06.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:14:0) after 1m0s
[03:12:06.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:14:0)
[03:12:06.335] Timer tick, asking Buildbucket for the build status
[03:12:07.052] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:07.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:15:0) after 1m0s
[03:13:07.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:15:0)
[03:13:07.215] Timer tick, asking Buildbucket for the build status
[03:13:07.569] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:07.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:16:0) after 1m0s
[03:14:07.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:16:0)
[03:14:07.654] Timer tick, asking Buildbucket for the build status
[03:14:07.735] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:07.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:17:0) after 1m0s
[03:15:07.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:17:0)
[03:15:07.853] Timer tick, asking Buildbucket for the build status
[03:15:08.316] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:08.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:18:0) after 1m0s
[03:16:08.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:18:0)
[03:16:08.341] Timer tick, asking Buildbucket for the build status
[03:16:08.429] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:08.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:19:0) after 1m0s
[03:17:08.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:19:0)
[03:17:08.555] Timer tick, asking Buildbucket for the build status
[03:17:08.677] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:08.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:20:0) after 1m0s
[03:18:08.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:20:0)
[03:18:08.803] Timer tick, asking Buildbucket for the build status
[03:18:08.944] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:08.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:21:0) after 1m0s
[03:19:09.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:21:0)
[03:19:09.034] Timer tick, asking Buildbucket for the build status
[03:19:09.650] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:09.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:22:0) after 1m0s
[03:20:09.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:22:0)
[03:20:09.681] Timer tick, asking Buildbucket for the build status
[03:20:09.903] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:09.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:23:0) after 1m0s
[03:21:10.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:23:0)
[03:21:10.031] Timer tick, asking Buildbucket for the build status
[03:21:10.235] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:10.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:24:0) after 1m0s
[03:22:10.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:24:0)
[03:22:10.307] Timer tick, asking Buildbucket for the build status
[03:22:10.597] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:10.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:25:0) after 1m0s
[03:23:10.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:25:0)
[03:23:10.778] Timer tick, asking Buildbucket for the build status
[03:23:10.875] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:10.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:26:0) after 1m0s
[03:24:10.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:26:0)
[03:24:10.994] Timer tick, asking Buildbucket for the build status
[03:24:11.643] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:11.643] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:27:0) after 1m0s
[03:25:11.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:27:0)
[03:25:11.709] Timer tick, asking Buildbucket for the build status
[03:25:12.099] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:12.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:28:0) after 1m0s
[03:26:12.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:28:0)
[03:26:12.195] Timer tick, asking Buildbucket for the build status
[03:26:12.264] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:12.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:29:0) after 1m0s
[03:27:12.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:29:0)
[03:27:12.301] Timer tick, asking Buildbucket for the build status
[03:27:12.397] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:12.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:30:0) after 1m0s
[03:28:12.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:30:0)
[03:28:12.457] Timer tick, asking Buildbucket for the build status
[03:28:12.530] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:12.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:31:0) after 1m0s
[03:29:12.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:31:0)
[03:29:12.601] Timer tick, asking Buildbucket for the build status
[03:29:12.773] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:12.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:32:0) after 1m0s
[03:30:12.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:32:0)
[03:30:12.895] Timer tick, asking Buildbucket for the build status
[03:30:13.613] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:13.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:33:0) after 1m0s
[03:31:13.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:33:0)
[03:31:13.747] Timer tick, asking Buildbucket for the build status
[03:31:13.901] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:13.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:34:0) after 1m0s
[03:32:14.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:34:0)
[03:32:14.057] Timer tick, asking Buildbucket for the build status
[03:32:14.140] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:14.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:35:0) after 1m0s
[03:33:14.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:35:0)
[03:33:14.296] Timer tick, asking Buildbucket for the build status
[03:33:14.596] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:14.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:36:0) after 1m0s
[03:34:14.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:36:0)
[03:34:14.731] Timer tick, asking Buildbucket for the build status
[03:34:14.979] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:14.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:37:0) after 1m0s
[03:35:15.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:37:0)
[03:35:15.103] Timer tick, asking Buildbucket for the build status
[03:35:15.218] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:15.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:38:0) after 1m0s
[03:36:15.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:38:0)
[03:36:15.278] Timer tick, asking Buildbucket for the build status
[03:36:15.345] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:15.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:39:0) after 1m0s
[03:37:15.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:39:0)
[03:37:15.372] Timer tick, asking Buildbucket for the build status
[03:37:15.755] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:15.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:40:0) after 1m0s
[03:38:15.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:40:0)
[03:38:15.826] Timer tick, asking Buildbucket for the build status
[03:38:15.934] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:15.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:41:0) after 1m0s
[03:39:15.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:41:0)
[03:39:15.981] Timer tick, asking Buildbucket for the build status
[03:39:16.134] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:16.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:42:0) after 1m0s
[03:40:16.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:42:0)
[03:40:16.191] Timer tick, asking Buildbucket for the build status
[03:40:16.405] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:16.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:43:0) after 1m0s
[03:41:16.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:43:0)
[03:41:16.453] Timer tick, asking Buildbucket for the build status
[03:41:16.613] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:16.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:44:0) after 1m0s
[03:42:16.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:44:0)
[03:42:16.644] Timer tick, asking Buildbucket for the build status
[03:42:16.927] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:16.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:45:0) after 1m0s
[03:43:17.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:45:0)
[03:43:17.206] Timer tick, asking Buildbucket for the build status
[03:43:17.347] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:17.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:46:0) after 1m0s
[03:44:17.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:46:0)
[03:44:17.458] Timer tick, asking Buildbucket for the build status
[03:44:17.580] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:17.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:47:0) after 1m0s
[03:45:17.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:47:0)
[03:45:17.797] Timer tick, asking Buildbucket for the build status
[03:45:17.929] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:17.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:48:0) after 1m0s
[03:46:18.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:48:0)
[03:46:18.207] Timer tick, asking Buildbucket for the build status
[03:46:18.585] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:18.585] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:49:0) after 1m0s
[03:47:18.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:49:0)
[03:47:18.738] Timer tick, asking Buildbucket for the build status
[03:47:19.159] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:19.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:50:0) after 1m0s
[03:48:19.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:50:0)
[03:48:19.423] Timer tick, asking Buildbucket for the build status
[03:48:19.613] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:19.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:51:0) after 1m0s
[03:49:19.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:51:0)
[03:49:19.638] Timer tick, asking Buildbucket for the build status
[03:49:19.799] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:19.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:52:0) after 1m0s
[03:50:19.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:52:0)
[03:50:19.824] Timer tick, asking Buildbucket for the build status
[03:50:20.974] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:20.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:53:0) after 1m0s
[03:51:21.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:53:0)
[03:51:21.082] Timer tick, asking Buildbucket for the build status
[03:51:21.422] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:21.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:54:0) after 1m0s
[03:52:21.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:54:0)
[03:52:21.504] Timer tick, asking Buildbucket for the build status
[03:52:21.617] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:21.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:55:0) after 1m0s
[03:53:21.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:55:0)
[03:53:21.675] Timer tick, asking Buildbucket for the build status
[03:53:22.183] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:22.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:56:0) after 1m0s
[03:54:22.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:56:0)
[03:54:22.237] Timer tick, asking Buildbucket for the build status
[03:54:22.346] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:22.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:57:0) after 1m0s
[03:55:22.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:57:0)
[03:55:22.416] Timer tick, asking Buildbucket for the build status
[03:55:22.542] Build 8863781353712834176: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:22.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9029211415722915728:58:0) after 1m0s
[03:56:23.293] Received PubSub notification, asking Buildbucket for the build status
[03:56:23.376] Build 8863781353712834176: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:56:23.376] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605239780313902",
"created_by": "project:chromium",
"created_ts": "1605236398931007",
"id": "8863781353712834176",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dd5b863bad31837551a992bf81edc3efc8981020\"}}",
"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\": \"dd5b863bad31837551a992bf81edc3efc8981020\", \"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-114-jw8n\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 42824, \"got_angle_revision\": \"f9e59ad078552424ca165644f4da3b4e2687c3dc\", \"got_dawn_revision\": \"8d69298d9b2938dcac52a08451b4f63fb61c31cb\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"dd5b863bad31837551a992bf81edc3efc8981020\", \"got_revision_cp\": \"refs/heads/master@{#827103}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"fd0d0441ca1e60bfe197b976662fa6342202ac25\", \"got_v8_revision\": \"2dbcdc105b963ee2501c82139eef7e0603977ff0\", \"got_v8_revision_cp\": \"refs/heads/8.8.278@{#1}\", \"got_webrtc_revision\": \"daab6896e2938e28f01e305ce2fff038f47554c4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32599}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-rel\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dd5b863bad31837551a992bf81edc3efc8981020\", \"swarm_hashes_refs/heads/master(at){#827103}_without_patch\": {\"absl_hardening_tests\": \"f573ea00c3b63589216eb520690de2b845441bd5\", \"accessibility_unittests\": \"9e472d563d4f7556e0b79de673679f8aa30476cc\", \"angle_unittests\": \"c91dcde0ac0d5e7d4da2cf3d3afe402dd3a074e4\", \"app_list_unittests\": \"c6f19c8245cc08da7899466acb62384940a0ef1e\", \"app_shell_unittests\": \"cebed682eeb658ed3fa1fcca98523e042c1d60a1\", \"ash_unittests\": \"35c9b9297f18e77669311f51ef04aa01f62a1f5d\", \"aura_unittests\": \"5adf4f7f43db1d930d900a2a29cb30b28adf3e39\", \"base_unittests\": \"c2b626dc31d61be628027335437e7305bc1b659c\", \"base_util_unittests\": \"676ba9b5415c200f6b94128a4f57844ce63bcf62\", \"blink_common_unittests\": \"5dedc98c645f4f6968d710dd6b64bfce0caf4680\", \"blink_fuzzer_unittests\": \"f99fc12dafc43bdd4c74ecfb0b2a313e611ce770\", \"blink_heap_unittests\": \"e7466cf9c8c5bc66df7e2e795d510b5ea10d09fa\", \"blink_platform_unittests\": \"75aa7b26631d14d32d1b6a0248cc4db41648c8a8\", \"blink_unittests\": \"b3f5b29d622e5c05990ee55b8e7deee50b0a67b4\", \"boringssl_crypto_tests\": \"f612a14f9f3206da715febf04208e0a9b3afdd4f\", \"boringssl_ssl_tests\": \"03d1982f90afdaf1504453359ca19d51726837c5\", \"browser_tests\": \"9484d16911c817bf8482939e4e5cc1d7fc76bf3d\", \"capture_unittests\": \"9538820a947814b23fd74137db4bc3b54e7743f9\", \"cast_unittests\": \"cdd08ad56f18e78a6841c6f5ebd6fed9d33474d3\", \"cc_unittests\": \"4bfcf0a933cdbe6adff21e42d1ef106da889981e\", \"chrome_app_unittests\": \"e4c0d7bf8b5cbc637f6a6f3e71c7c5573da3efa9\", \"chromedriver_unittests\": \"8343f20757ce360da63dc124b7afbb4e2ef9aa72\", \"chromeos_components_unittests\": \"6cf7d4f1573fbc28e2c8aba8066a24aef2b54ca5\", \"chromeos_unittests\": \"3b152bb9d68b727c38245cb6b7f5dc676e8c6299\", \"components_browsertests\": \"b791cf6ae5fba238e8aa3fb77773040177bbeb14\", \"components_unittests\": \"87c3792f0f27531630f430dd6239fb7f3b0c9f01\", \"compositor_unittests\": \"95d417899dc4ed748e5c25abf8c939f92505e878\", \"content_browsertests\": \"33a839cfdf3298bc5187912d9b9e63520776fa77\", \"content_unittests\": \"4ffac6eafa0ae40d23abdf58b7d45fc2e33e7035\", \"crashpad_tests\": \"1c2f2f595c99bf0cf07190a3896e9a3fe807f77e\", \"crypto_unittests\": \"09b675b6edb0c9c8e316e34a28bb2e386333dd02\", \"dbus_unittests\": \"26fbdbf88642c21d86f498068ecefa97a9e585a6\", \"device_unittests\": \"cd82a036dccc439e55e1186c077cec6f2a306a98\", \"display_unittests\": \"9d18926568137e8c54c888446ccf4235366e0c9b\", \"events_unittests\": \"d149dbc616deed4c552444adbe041a6868146d64\", \"exo_unittests\": \"e5f11700d6b3a75f84e046b806e66f515df0392a\", \"extensions_browsertests\": \"3a156cde51771564399ecde599424bfc2353aae2\", \"extensions_unittests\": \"94d9c58c46314030e7943b77f87cb4c4f965eb10\", \"filesystem_service_unittests\": \"245aac4e40dc22f036df919f2b0de5a282fcc679\", \"gcm_unit_tests\": \"e4eca61445a37280623ed9ec28a1623dd8257b81\", \"gfx_unittests\": \"1722a4cae010539800f6b37713629f9fe64cf8e3\", \"gin_unittests\": \"5840e20a186bfd425b63396e249b4d34d6891b80\", \"gl_unittests_ozone\": \"2e441e7987c8d0b95f35b57099820c0388891106\", \"google_apis_unittests\": \"4e6eaf4ef38846968b95019291ca6da94dc29acd\", \"gpu_unittests\": \"c8831889a031b98af3f1ba5595cf342b2a44b718\", \"gwp_asan_unittests\": \"5d38899f3fe002a3bdbf19c1dbca9f431c0a6dfe\", \"interactive_ui_tests\": \"a1867c7be5cc911bccc42e488430513b349d085a\", \"ipc_tests\": \"3233f6bfcc9460424aa8c4a269b3d7768edd9b5c\", \"jingle_unittests\": \"cd9b8227c718661fd3bc60aace6ba3926dae755c\", \"keyboard_unittests\": \"8c69adc0f99cdfbbc6f4aeab1bd6f06e9d73a0da\", \"latency_unittests\": \"f6b7eb1add21eb29d708ae961125a9b4226d916b\", \"libjingle_xmpp_unittests\": \"8360d3e28ee373d599a7ab93faf493037a648ebc\", \"liburlpattern_unittests\": \"ef80226d08c8a6f3020d6ea824a357bf9710fe34\", \"media_blink_unittests\": \"30212508498669bd57c05563a712463a7029b984\", \"media_unittests\": \"8cfdb7e4ecdda971a37d2bbba2958c61bf78dff9\", \"message_center_unittests\": \"e8d52034d17a187e277f762fcc737daaa45ab8e5\", \"midi_unittests\": \"de6b77688c55e082590c30a8f7825ab8159a5d83\", \"mojo_core_unittests\": \"1999539639ab626f519f28a0add84d6afea4d973\", \"mojo_unittests\": \"4a33e5b48a492597e7df2c9519602a1f96bde6f2\", \"nacl_helper_nonsfi_unittests\": \"c27971ca2e11d6d0c0b373a1a843611b091ff78f\", \"nacl_loader_unittests\": \"2a75c228e99dcbcc6a4e00b3f96657b905138294\", \"native_theme_unittests\": \"a700652d350ff3341b3993bd786a44b9f78cafd8\", \"net_unittests\": \"89752bbc947fa8c3f8280f7133761c3519a2a0cf\", \"ozone_gl_unittests\": \"7cfaae38be87a10b7f899f039a65f19f874cc8a5\", \"ozone_unittests\": \"1cc2148232320478e8ae0a841bdb337aa5349e2f\", \"ozone_x11_unittests\": \"4f4ea15ca16ee45db6cbbf2b746d9a4df3b7734f\", \"pdf_unittests\": \"81af63399f603975bfe6d87c7496f53025dbf658\", \"perfetto_unittests\": \"25655471e1b484c6b7e0758e8fe040362e46bb31\", \"ppapi_unittests\": \"2bbf618659f9870321cae8d1851d30bbaa945119\", \"printing_unittests\": \"8586d7a040dc64382abac93fca7af9555a0b2d53\", \"remoting_unittests\": \"51580517b726a3e9ec4e765ec025c70efa61cb69\", \"sandbox_linux_unittests\": \"463579c9f930dde8ea5567f22010aed8122f0083\", \"service_manager_unittests\": \"45a11aabf7ce764a7a999c93d0371254a5091067\", \"services_unittests\": \"27cfcbc70290269db48dc5eea16272adc22b16d9\", \"shell_dialogs_unittests\": \"f2db00fe8c4b5fcf30022a759d60b3b123da7895\", \"skia_unittests\": \"c68797e49dc45fc9ba74e19e2ef09ee5637cd5bf\", \"snapshot_unittests\": \"3a54c1c7b9f9b84f48129378f340f0aaf56be643\", \"sql_unittests\": \"6af2a52c6500d86c14ae7c757da0603e841b81fa\", \"storage_unittests\": \"cb3b26588fb6dafd6496bd7601fe20ccd39befe7\", \"sync_integration_tests\": \"d7edcbf4cee4da8ad91071bea6339b971384dcee\", \"traffic_annotation_auditor_unittests\": \"4daac46d2628383fb829c192bc5be14e4f59de88\", \"ui_base_unittests\": \"c73477c209d2f87b362777ce35c7dc3ad883ce1c\", \"ui_chromeos_unittests\": \"aeed2cfbaee4bcba725fef75ddc98cbb8d83faeb\", \"ui_touch_selection_unittests\": \"ad1a21f2b4a51acfc7bda966a9dffe14d9060b22\", \"unit_tests\": \"3958f274f251283ade3c489c54500b9b915555f2\", \"url_unittests\": \"5d0f63cf196e735da991771a0e1a9cc040603af1\", \"usage_time_limit_unittests\": \"bd64e41a39d96687dcfb0b3e09e0dbab8d5888ef\", \"views_unittests\": \"b16258c8ea7a5fd3fdb1e4dcd80676b78e8b6877\", \"viz_unittests\": \"07620ecaf09171054d4f724e0e3c47278ea8b266\", \"wayland_client_perftests\": \"76652e98572965d5295dfaadc1ba20b5d33791f8\", \"wm_unittests\": \"f6bc3b8ef8f48dfdf5e7a3c8672c6e70e418fbf4\", \"wtf_unittests\": \"6fe690e2c0885d30581698779af82814eba02540\", \"zlib_unittests\": \"7aa3ad5cf5c9bdf6efb5bc89dae39f130524f7a7\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093d924ecb526dae9a1dcf9db4725f8944eec2b4c0f2ddc6c2ac4a04802f7f15_v2\", \"builder_510bb217f1fbd7cfc6f82b4f5538258f70582616cab4052bd10c7cd8994fe33a_v2\", \"builder_756d7885c4e2fdf98a0ecf3a0240e3f6188de5be53188a09baa9eae15dedd66f_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_d6e5378aee5938d080eb0dcdbd0211f3098981aa309245e37202498e30b4f23b_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-114-jw8n\"], \"image\": [\"chrome-xenial-20110100-7e97731f9b6\"], \"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\": [\"5626-39642e9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605236458154189",
"status": "COMPLETED",
"status_changed_ts": "1605239781515301",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/42824",
"builder:linux-chromeos-rel",
"buildset:commit/git/dd5b863bad31837551a992bf81edc3efc8981020",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd5b863bad31837551a992bf81edc3efc8981020",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9029211415722915728",
"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/8863781353712834176/+/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:4fd85d3831c6d910",
"user_agent:luci-scheduler"
],
"updated_ts": "1605239781591190",
"url": "https://ci.chromium.org/b/8863781353712834176",
"utcnow_ts": "1605239783363285"
}
}
[03:56:23.376] Invocation finished in 56m25.745584416s with status SUCCEEDED