[09:36:42.739] New invocation is queued and will start shortly
[09:36:43.877] Starting the invocation (attempt 1)
[09:36:43.926] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:36:43.926] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:36:43.926] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018496012238131104",
"parameters_json": "{\"builder_name\":\"linux-chromeos-rel\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7aadf8db67182947340237d346e50f5197cdb1a3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-rel",
"scheduler_invocation_id:9018496012238131104",
"scheduler_job_id:chromium/linux-chromeos-rel",
"user_agent:luci-scheduler",
"buildset:commit/git/7aadf8db67182947340237d346e50f5197cdb1a3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7aadf8db67182947340237d346e50f5197cdb1a3",
"gitiles_ref:refs/heads/master"
]
}
[09:36:44.479] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615455404017023",
"id": "8853065950235620624",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7aadf8db67182947340237d346e50f5197cdb1a3\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615455404345901",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46069",
"builder:linux-chromeos-rel",
"buildset:commit/git/7aadf8db67182947340237d346e50f5197cdb1a3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7aadf8db67182947340237d346e50f5197cdb1a3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018496012238131104",
"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/8853065950235620624/+/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": "1615455404346082",
"url": "https://ci.chromium.org/b/8853065950235620624",
"utcnow_ts": "1615455404471033"
}
}
[09:36:44.479] Task URL: https://ci.chromium.org/b/8853065950235620624
[09:36:44.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:2:0) after 1m0s
[09:37:44.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:2:0)
[09:37:44.621] Timer tick, asking Buildbucket for the build status
[09:37:44.938] Build 8853065950235620624: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:37:44.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:3:0) after 1m0s
[09:38:28.072] Received PubSub notification, asking Buildbucket for the build status
[09:38:28.208] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:44.963] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:3:0)
[09:38:44.963] Timer tick, asking Buildbucket for the build status
[09:38:45.023] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:45.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:5:0) after 1m0s
[09:39:45.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:5:0)
[09:39:45.073] Timer tick, asking Buildbucket for the build status
[09:39:45.320] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:45.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:6:0) after 1m0s
[09:40:45.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:6:0)
[09:40:45.286] Timer tick, asking Buildbucket for the build status
[09:40:45.652] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:45.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:7:0) after 1m0s
[09:41:45.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:7:0)
[09:41:45.646] Timer tick, asking Buildbucket for the build status
[09:41:45.962] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:45.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:8:0) after 1m0s
[09:42:46.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:8:0)
[09:42:46.015] Timer tick, asking Buildbucket for the build status
[09:42:46.079] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:46.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:9:0) after 1m0s
[09:43:46.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:9:0)
[09:43:46.075] Timer tick, asking Buildbucket for the build status
[09:43:46.155] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:46.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:10:0) after 1m0s
[09:44:46.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:10:0)
[09:44:46.206] Timer tick, asking Buildbucket for the build status
[09:44:46.425] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:46.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:11:0) after 1m0s
[09:45:46.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:11:0)
[09:45:46.416] Timer tick, asking Buildbucket for the build status
[09:45:46.597] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:46.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:12:0) after 1m0s
[09:46:46.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:12:0)
[09:46:46.631] Timer tick, asking Buildbucket for the build status
[09:46:46.913] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:46.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:13:0) after 1m0s
[09:47:46.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:13:0)
[09:47:46.994] Timer tick, asking Buildbucket for the build status
[09:47:47.074] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:47.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:14:0) after 1m0s
[09:48:47.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:14:0)
[09:48:47.068] Timer tick, asking Buildbucket for the build status
[09:48:47.222] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:47.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:15:0) after 1m0s
[09:49:47.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:15:0)
[09:49:47.257] Timer tick, asking Buildbucket for the build status
[09:49:47.539] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:47.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:16:0) after 1m0s
[09:50:47.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:16:0)
[09:50:47.575] Timer tick, asking Buildbucket for the build status
[09:50:47.669] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:47.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:17:0) after 1m0s
[09:51:47.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:17:0)
[09:51:47.688] Timer tick, asking Buildbucket for the build status
[09:51:47.771] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:47.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:18:0) after 1m0s
[09:52:47.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:18:0)
[09:52:47.794] Timer tick, asking Buildbucket for the build status
[09:52:47.861] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:47.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:19:0) after 1m0s
[09:53:47.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:19:0)
[09:53:47.879] Timer tick, asking Buildbucket for the build status
[09:53:47.949] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:47.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:20:0) after 1m0s
[09:54:47.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:20:0)
[09:54:47.980] Timer tick, asking Buildbucket for the build status
[09:54:48.055] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:48.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:21:0) after 1m0s
[09:55:48.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:21:0)
[09:55:48.076] Timer tick, asking Buildbucket for the build status
[09:55:48.140] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:48.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:22:0) after 1m0s
[09:56:48.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:22:0)
[09:56:48.137] Timer tick, asking Buildbucket for the build status
[09:56:48.245] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:48.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:23:0) after 1m0s
[09:57:48.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:23:0)
[09:57:48.283] Timer tick, asking Buildbucket for the build status
[09:57:48.347] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:48.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:24:0) after 1m0s
[09:58:48.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:24:0)
[09:58:48.471] Timer tick, asking Buildbucket for the build status
[09:58:48.546] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:48.546] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:25:0) after 1m0s
[09:59:48.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:25:0)
[09:59:48.611] Timer tick, asking Buildbucket for the build status
[09:59:48.751] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:48.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:26:0) after 1m0s
[10:00:48.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:26:0)
[10:00:48.858] Timer tick, asking Buildbucket for the build status
[10:00:49.027] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:49.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:27:0) after 1m0s
[10:01:49.116] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:27:0)
[10:01:49.116] Timer tick, asking Buildbucket for the build status
[10:01:49.203] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:49.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:28:0) after 1m0s
[10:02:49.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:28:0)
[10:02:49.202] Timer tick, asking Buildbucket for the build status
[10:02:49.340] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:49.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:29:0) after 1m0s
[10:03:49.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:29:0)
[10:03:49.434] Timer tick, asking Buildbucket for the build status
[10:03:49.518] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:49.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:30:0) after 1m0s
[10:04:49.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:30:0)
[10:04:49.544] Timer tick, asking Buildbucket for the build status
[10:04:49.610] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:49.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:31:0) after 1m0s
[10:05:49.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:31:0)
[10:05:49.665] Timer tick, asking Buildbucket for the build status
[10:05:49.748] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:49.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:32:0) after 1m0s
[10:06:49.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:32:0)
[10:06:49.812] Timer tick, asking Buildbucket for the build status
[10:06:50.155] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:50.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:33:0) after 1m0s
[10:07:50.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:33:0)
[10:07:50.214] Timer tick, asking Buildbucket for the build status
[10:07:50.552] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:50.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:34:0) after 1m0s
[10:08:50.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:34:0)
[10:08:50.577] Timer tick, asking Buildbucket for the build status
[10:08:50.642] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:50.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:35:0) after 1m0s
[10:09:50.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:35:0)
[10:09:50.728] Timer tick, asking Buildbucket for the build status
[10:09:50.903] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:50.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:36:0) after 1m0s
[10:10:50.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:36:0)
[10:10:50.968] Timer tick, asking Buildbucket for the build status
[10:10:51.029] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:51.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:37:0) after 1m0s
[10:11:51.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:37:0)
[10:11:51.138] Timer tick, asking Buildbucket for the build status
[10:11:51.299] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:51.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:38:0) after 1m0s
[10:12:51.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:38:0)
[10:12:51.375] Timer tick, asking Buildbucket for the build status
[10:12:51.440] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:51.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:39:0) after 1m0s
[10:13:51.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:39:0)
[10:13:51.480] Timer tick, asking Buildbucket for the build status
[10:13:51.750] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:51.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:40:0) after 1m0s
[10:14:51.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:40:0)
[10:14:51.756] Timer tick, asking Buildbucket for the build status
[10:14:51.899] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:51.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:41:0) after 1m0s
[10:15:51.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:41:0)
[10:15:51.904] Timer tick, asking Buildbucket for the build status
[10:15:51.973] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:51.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:42:0) after 1m0s
[10:16:52.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:42:0)
[10:16:52.042] Timer tick, asking Buildbucket for the build status
[10:16:52.531] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:52.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:43:0) after 1m0s
[10:17:52.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:43:0)
[10:17:52.564] Timer tick, asking Buildbucket for the build status
[10:17:52.630] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:52.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:44:0) after 1m0s
[10:18:52.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:44:0)
[10:18:52.664] Timer tick, asking Buildbucket for the build status
[10:18:52.744] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:52.744] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:45:0) after 1m0s
[10:19:52.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:45:0)
[10:19:52.778] Timer tick, asking Buildbucket for the build status
[10:19:52.856] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:52.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:46:0) after 1m0s
[10:20:52.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:46:0)
[10:20:52.904] Timer tick, asking Buildbucket for the build status
[10:20:52.980] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:52.980] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:47:0) after 1m0s
[10:21:53.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:47:0)
[10:21:53.073] Timer tick, asking Buildbucket for the build status
[10:21:53.151] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:53.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:48:0) after 1m0s
[10:22:53.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:48:0)
[10:22:53.191] Timer tick, asking Buildbucket for the build status
[10:22:53.301] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:53.301] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:49:0) after 1m0s
[10:23:53.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:49:0)
[10:23:53.324] Timer tick, asking Buildbucket for the build status
[10:23:53.519] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:53.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:50:0) after 1m0s
[10:24:53.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:50:0)
[10:24:53.540] Timer tick, asking Buildbucket for the build status
[10:24:53.907] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:53.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:51:0) after 1m0s
[10:25:53.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:51:0)
[10:25:53.967] Timer tick, asking Buildbucket for the build status
[10:25:54.051] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:54.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:52:0) after 1m0s
[10:26:54.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:52:0)
[10:26:54.098] Timer tick, asking Buildbucket for the build status
[10:26:54.317] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:54.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:53:0) after 1m0s
[10:27:54.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:53:0)
[10:27:54.349] Timer tick, asking Buildbucket for the build status
[10:27:54.644] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:54.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:54:0) after 1m0s
[10:28:54.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:54:0)
[10:28:54.645] Timer tick, asking Buildbucket for the build status
[10:28:54.718] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:54.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:55:0) after 1m0s
[10:29:54.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:55:0)
[10:29:54.784] Timer tick, asking Buildbucket for the build status
[10:29:54.867] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:54.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:56:0) after 1m0s
[10:30:54.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:56:0)
[10:30:54.936] Timer tick, asking Buildbucket for the build status
[10:30:55.017] Build 8853065950235620624: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:55.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-rel:9018496012238131104:57:0) after 1m0s
[10:31:19.824] Received PubSub notification, asking Buildbucket for the build status
[10:31:19.902] Build 8853065950235620624: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:31:19.902] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615458678570097",
"created_by": "project:chromium",
"created_ts": "1615455404017023",
"id": "8853065950235620624",
"parameters_json": "{\"builder_name\": \"linux-chromeos-rel\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7aadf8db67182947340237d346e50f5197cdb1a3\"}}",
"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\": \"7aadf8db67182947340237d346e50f5197cdb1a3\", \"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-119-2w3r\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-rel\", \"buildnumber\": 46069, \"got_angle_revision\": \"44b9579cf7b8d35cac13f9e2d70c57791ddfd0e2\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"7aadf8db67182947340237d346e50f5197cdb1a3\", \"got_revision_cp\": \"refs/heads/master@{#861912}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a2fe8e1b2111e69d8846991f9d9bcc5c49505d1c\", \"got_v8_revision\": \"9c91874d93f2ca4e7df23a7abdb80bb888afb20b\", \"got_v8_revision_cp\": \"refs/heads/9.1.98@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"is_cached\": true, \"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\": \"7aadf8db67182947340237d346e50f5197cdb1a3\", \"swarm_hashes_refs/heads/master(at){#861912}_without_patch\": {\"absl_hardening_tests\": \"1c9d62218c85cf829f7e1c863dad9701b5496ff2\", \"accessibility_unittests\": \"1ab4c1415a0fa83d70bd2aa38abc2796c1ccc9a0\", \"angle_unittests\": \"10e6bd248eaefe83f7e9ae2e279f2ed5e789c397\", \"app_list_unittests\": \"7267c9a29a316b3dd5d7285701b006743ca89edf\", \"app_shell_unittests\": \"5e5d729df73ec612e1159c854171f21f1bcdbfcf\", \"ash_unittests\": \"2cbbf13a968d4bbcd3d79896ea7513beb6da1b46\", \"aura_unittests\": \"f179f173d6d237a11f7d6d276f521595596fbece\", \"base_unittests\": \"f8b5665ebb4f46a49aa91f28ff9fbf4a98c0210e\", \"base_util_unittests\": \"eefaefed43baf35b7e05ea133dcd58a85716871b\", \"blink_common_unittests\": \"77f27b45fdddca09938b25accdc67cf54a409432\", \"blink_fuzzer_unittests\": \"aa09fb1d404c56e0c6aa55d3e3fe6687d4ba8678\", \"blink_heap_unittests\": \"b20569b2f48d8a1fd88677b304e0811c63b8f0f1\", \"blink_platform_unittests\": \"6f253f4721299c93aad5113c0f66eae384014ae7\", \"blink_unittests\": \"9c76d5b7640a2d295acf458082a59c4cc92e15dd\", \"boringssl_crypto_tests\": \"b8bb6a974af407dfbb1ef772b0f898441b8d980d\", \"boringssl_ssl_tests\": \"9e21a4809213a77160b6760706430d9f0e13474c\", \"browser_tests\": \"f708f82ebbe27f8e8909811d49eda23e3d6ca923\", \"capture_unittests\": \"60353ba0b8927455c8515666e3930f4217e42de1\", \"cast_unittests\": \"e18f515844d83d50fab05915401339b7c3506267\", \"cc_unittests\": \"86964083a0a78fff2430fdf3788824da43df2879\", \"chrome_app_unittests\": \"e8f3c072c31f530f866ef940b138a30da9c46602\", \"chromedriver_unittests\": \"927d1ff5b702e0e9040d7890a2a59f0ce3287a68\", \"chromeos_components_unittests\": \"fe46c87319c0a2907c368bee7737f23bd03ef62e\", \"chromeos_unittests\": \"871d6cc37918e5297a0dec2ccbe6159f94a6536d\", \"color_unittests\": \"3204546a8856af0c9e60ac08ac65df65de301c57\", \"components_browsertests\": \"a076279de0e3690b357534e71edde7fc3607cda3\", \"components_unittests\": \"e60206474d771b5b570b1f824b9409060bf3be4f\", \"compositor_unittests\": \"e9b5bd6fb7f270891930a21dd8b39030f47f2787\", \"content_browsertests\": \"575588cdef5a3e5e4873d977b9300cf6a9fad27f\", \"content_unittests\": \"a5f8eda2a1aadddd214752da7b2413cf14f25fd9\", \"crashpad_tests\": \"0b29d025b97be0ef58735e4b43e52bbd0adde46d\", \"crypto_unittests\": \"676646fe05a411728fe406fb6bee9d73be909f60\", \"dbus_unittests\": \"6423d3ca3cc36eedfa99d0af489b85c24085669c\", \"device_unittests\": \"1774acee589a9cf2f7aa3f6f1bc9d3d61ad0842f\", \"display_unittests\": \"7f2c88266f77471e009eb9aa8e6e514649911266\", \"events_unittests\": \"f0ba80acd0e4cf20c44b89fcabda7a579ab0a255\", \"exo_unittests\": \"d20c3a3acb64f8d9e40481c63614be0cdc29519f\", \"extensions_browsertests\": \"0bcfc5d6d77ffd669caf225d10ad4c4a52cd1aee\", \"extensions_unittests\": \"7cd37b660cf186a1bebab64b2d797c4265b89c2d\", \"filesystem_service_unittests\": \"fa8761222407f27ea1172f0881758f2f4ec5c81b\", \"gcm_unit_tests\": \"8ced01ba6723e1e0c282799c2cee8358a171b044\", \"gfx_unittests\": \"a1adc473731769ffd1fb4ed4c016c338b8edc3b6\", \"gin_unittests\": \"d5cb5c1f60706a3fe8d25ec2c66372f74c6ed1ec\", \"gl_unittests_ozone\": \"fe99d79a9d47427810ca4f1a394694da80612252\", \"google_apis_unittests\": \"75e0b441bc20d3eb6e63a3631004644a170abfc1\", \"gpu_unittests\": \"00f9b77902696c651cbaf9135fdb26d278547a98\", \"gwp_asan_unittests\": \"8d52be78578f8430f9ae68c4cef9e44f4b3c65bc\", \"interactive_ui_tests\": \"a46a19b39498e970510207189c55c7256ba75a0b\", \"ipc_tests\": \"6f576bad0aa4e5d4336008fb5d1e0a4e669189d7\", \"jingle_unittests\": \"81f37f0cc64000657e0997c2273098203a47152e\", \"keyboard_unittests\": \"a18f41993dd12c64bfc60d7f30c219a4324d1b2f\", \"latency_unittests\": \"cc02aa1c45e9a4f1a2b5f46ba3b0bf4510604c2f\", \"libjingle_xmpp_unittests\": \"2531910f540d0385aaf0add81b683e9bbcf20844\", \"liburlpattern_unittests\": \"fa0e0aacfead8be1d045c9eda1445ade87861694\", \"media_blink_unittests\": \"2dcd91a8527867cad6f9a55ecf259b606a5af8d2\", \"media_unittests\": \"9071a8d406fed74e1598b9a4fc851de72d7d5ef5\", \"message_center_unittests\": \"37aa4b2f7498e44ee2fba5e7b58d9ded0bca7cfb\", \"midi_unittests\": \"a9a50b0b16ca7dcc22355e85eff94bb64a9ddd1e\", \"mojo_core_unittests\": \"62700021476ed6b0f9125b07759767ca986d05a1\", \"mojo_unittests\": \"486f5c6a525e4bf6b02e682217547ceb96cad191\", \"nacl_helper_nonsfi_unittests\": \"0b0d80dfb9e6705963c7710a7d27343053d33c3e\", \"nacl_loader_unittests\": \"48f3fc459135e89ab9c58da2d944ebccea1d5700\", \"native_theme_unittests\": \"29511d8c12702bf3e80bcbe82eef29e80bc82e66\", \"net_unittests\": \"da11bb137f80a1520d07ba8ccafc7b88a68116d9\", \"ozone_gl_unittests\": \"7288d29d5307ee52f726fff565a33a43dc9b3711\", \"ozone_unittests\": \"efaca3e38d0dd909a0c8cd28bc2e1e32a0ee8a06\", \"ozone_x11_unittests\": \"8bc277eb29301774b9aab840628e8b402c47fb89\", \"pdf_unittests\": \"704d170a4dd64b8494e8babbda92a4839af38734\", \"perfetto_unittests\": \"1655eb38ea0947e15c2981eeb7e100dba00b2723\", \"ppapi_unittests\": \"0f1b61505523400ce19f266d2f34fc851e86375a\", \"printing_unittests\": \"b38e7263c8054a5f30a80e1a7e19fe792934c4eb\", \"remoting_unittests\": \"1af3c1f17cfebaff46253809914f26ea6c07b76f\", \"sandbox_linux_unittests\": \"c1afe9c874be84cc18989f7603e2b334153fe80b\", \"service_manager_unittests\": \"e46ecbc6b5078b92def932fa14260633dd896d6a\", \"services_unittests\": \"8ab9cd071ee0b79e641b993d5efa30aea2a91b9a\", \"shell_dialogs_unittests\": \"2c1f0b47c2bf5a9f97123606ebb77d9aafe950b8\", \"shell_encryption_unittests\": \"196a878e814b356d60bce83696ad55eb5dbcca0b\", \"skia_unittests\": \"a8b1581f8240893bbeee9ff54760433640970daa\", \"snapshot_unittests\": \"1a5e9a76861d8a4ba0c8cb7e20f577d5dd04f08e\", \"sql_unittests\": \"18ee781ae8c0d62f6a2bf7519db2503ecce0f2c7\", \"storage_unittests\": \"0068c86c830a64f219b460eef0d3f848ad2bdc6c\", \"sync_integration_tests\": \"35eec7b436907cb5f04d8dee898b19e22afc96ca\", \"traffic_annotation_auditor_unittests\": \"e0df1d8b2c545d476d9b9f0c6b0e9f5c74e3ff43\", \"ui_base_unittests\": \"fc3134d10c737650b72fa64dc9f28c49b980c147\", \"ui_chromeos_unittests\": \"65e94dba5d9e48422a5f7d9f8270b526d23946c5\", \"ui_touch_selection_unittests\": \"a21447f5485cb67f2738fc5e618222d4674cb5d8\", \"unit_tests\": \"2449f0db6c00704ff749c5f473dd00010306720c\", \"url_unittests\": \"7e73a766cfd8ef9e9aebe8d3015360c47f306849\", \"usage_time_limit_unittests\": \"f0ddf486394763d5920e62faf5cdf1e8cbb1796f\", \"views_unittests\": \"d4199e72295611f47c65fb243f57905c006097b1\", \"viz_unittests\": \"3769b9ec73de802ad1f8c73e099f430e8a9bb740\", \"wayland_client_perftests\": \"34d4360a81fd9053baf28ab33c22794753bd3d20\", \"wayland_client_tests\": \"09bbaec9ab6fddd3c684fa339c3693ba606404f6\", \"wm_unittests\": \"0538b1fd48044fcd24eca2b3f786208e029d522a\", \"wtf_unittests\": \"47253b2949a9971db3045a30cbcbf477948ec50a\", \"zlib_unittests\": \"7cf2bd67061b0d460157c75e0321645555a441ca\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_41a56887a5f94da437bca02a8352f9969580ae835cf23972ebecbddbd7380819_v2\", \"builder_51829829c31fbaf3768e3309e640f1ed37e0867e138bde8c875431bcab07adc2_v2\", \"builder_6012964051d5021e7307eb12ad598b318c657120f21d3654d81218fef56916e6_v2\", \"builder_8afdcfef4ae6fecf44bdc59bc36ab1bd30dfc75b00b262fd5e6b3421af127659_v2\", \"builder_94fa3119a28f4651cdd4fc5b981a64c69b26c151212072333439362290628993_v2\", \"builder_c49efc2b6fcfe67b72a35f6b436282fc6c4393b61b532dfc8ddacf832f201b2b_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_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-119-2w3r\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615455506926868",
"status": "COMPLETED",
"status_changed_ts": "1615458679025111",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-rel/46069",
"builder:linux-chromeos-rel",
"buildset:commit/git/7aadf8db67182947340237d346e50f5197cdb1a3",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7aadf8db67182947340237d346e50f5197cdb1a3",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018496012238131104",
"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/8853065950235620624/+/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:523976ca94a7bf10",
"user_agent:luci-scheduler"
],
"updated_ts": "1615458679029696",
"url": "https://ci.chromium.org/b/8853065950235620624",
"utcnow_ts": "1615458679892475"
}
}
[10:31:19.902] Invocation finished in 54m37.177682178s with status SUCCEEDED